builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1465613776.7 results: success (0) buildid: 20160610173004 builduid: d2212d0c190641d1aa32fc684d205bab revision: 618a8336136754762b1002f9838fa574ffc60937 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:16.704552) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:16.705211) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:16.705705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:16.836928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:16.837389) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1465612445.995203-1538470066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 19:56:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.1M=0s 2016-06-10 19:56:17 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074554 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:16.952761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:16.953069) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1465612445.995203-1538470066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:17.009363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 19:56:17.009958) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 618a8336136754762b1002f9838fa574ffc60937 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 618a8336136754762b1002f9838fa574ffc60937 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1465612445.995203-1538470066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 19:56:17,776 truncating revision to first 12 chars 2016-06-10 19:56:17,776 Setting DEBUG logging. 2016-06-10 19:56:17,776 attempt 1/10 2016-06-10 19:56:17,776 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/618a83361367?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 19:56:18,551 unpacking tar archive at: fx-team-618a83361367/testing/mozharness/ program finished with exit code 0 elapsedTime=1.097616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 19:56:18.129026) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:18.129706) ========= script_repo_revision: 618a8336136754762b1002f9838fa574ffc60937 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:18.130421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:18.131096) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 19:56:18.147627) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-10 19:56:18.147893) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1465612445.995203-1538470066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:56:18 INFO - MultiFileLogger online at 20160610 19:56:18 in /builds/slave/test 19:56:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:56:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:56:18 INFO - {'append_to_log': False, 19:56:18 INFO - 'base_work_dir': '/builds/slave/test', 19:56:18 INFO - 'blob_upload_branch': 'Fx-Team', 19:56:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:56:18 INFO - 'branch': 'Fx-Team', 19:56:18 INFO - 'buildbot_json_path': 'buildprops.json', 19:56:18 INFO - 'config_files': ('talos/linux_config.py',), 19:56:18 INFO - 'default_actions': ('clobber', 19:56:18 INFO - 'read-buildbot-config', 19:56:18 INFO - 'download-and-extract', 19:56:18 INFO - 'populate-webroot', 19:56:18 INFO - 'create-virtualenv', 19:56:18 INFO - 'install', 19:56:18 INFO - 'run-tests'), 19:56:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:56:18 INFO - 'download_minidump_stackwalk': True, 19:56:18 INFO - 'download_symbols': 'ondemand', 19:56:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:56:18 INFO - 'tooltool.py': '/tools/tooltool.py', 19:56:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:56:18 INFO - '/tools/misc-python/virtualenv.py')}, 19:56:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:56:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:56:18 INFO - 'installer_path': 'installer.exe', 19:56:18 INFO - 'log_level': 'info', 19:56:19 INFO - 'log_name': 'talos', 19:56:19 INFO - 'log_to_console': True, 19:56:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:56:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:56:19 INFO - 'opt_config_files': (), 19:56:19 INFO - 'pip_index': False, 19:56:19 INFO - 'sps_profile': False, 19:56:19 INFO - 'sps_profile_interval': 0, 19:56:19 INFO - 'suite': 'dromaeojs', 19:56:19 INFO - 'system_bits': '32', 19:56:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:56:19 INFO - 'title': 'talos-linux64-ix-045', 19:56:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:56:19 INFO - 'use_talos_json': True, 19:56:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:56:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:56:19 INFO - 'work_dir': 'build'} 19:56:19 INFO - ##### 19:56:19 INFO - ##### Running clobber step. 19:56:19 INFO - ##### 19:56:19 INFO - Running pre-action listener: _resource_record_pre_action 19:56:19 INFO - Running main action method: clobber 19:56:19 INFO - rmtree: /builds/slave/test/build 19:56:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:56:19 INFO - Running post-action listener: _resource_record_post_action 19:56:19 INFO - ##### 19:56:19 INFO - ##### Finished clobber step (success) 19:56:19 INFO - ##### 19:56:19 INFO - ##### 19:56:19 INFO - ##### Running read-buildbot-config step. 19:56:19 INFO - ##### 19:56:19 INFO - Running pre-action listener: _resource_record_pre_action 19:56:19 INFO - Running main action method: read_buildbot_config 19:56:19 INFO - Using buildbot properties: 19:56:19 INFO - { 19:56:19 INFO - "project": "", 19:56:19 INFO - "product": "firefox", 19:56:19 INFO - "script_repo_revision": "production", 19:56:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:56:19 INFO - "repository": "", 19:56:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:56:19 INFO - "buildid": "20160610173004", 19:56:19 INFO - "pgo_build": "True", 19:56:19 INFO - "basedir": "/builds/slave/test", 19:56:19 INFO - "buildnumber": 1248, 19:56:19 INFO - "slavename": "talos-linux64-ix-045", 19:56:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:56:19 INFO - "platform": "ubuntu64_hw", 19:56:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:56:19 INFO - "branch": "fx-team", 19:56:19 INFO - "repo_path": "integration/fx-team", 19:56:19 INFO - "revision": "618a8336136754762b1002f9838fa574ffc60937", 19:56:19 INFO - "stage_platform": "linux64-pgo", 19:56:19 INFO - "builduid": "d2212d0c190641d1aa32fc684d205bab", 19:56:19 INFO - "slavebuilddir": "test" 19:56:19 INFO - } 19:56:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:56:19 INFO - Running post-action listener: _resource_record_post_action 19:56:19 INFO - ##### 19:56:19 INFO - ##### Finished read-buildbot-config step (success) 19:56:19 INFO - ##### 19:56:19 INFO - ##### 19:56:19 INFO - ##### Running download-and-extract step. 19:56:19 INFO - ##### 19:56:19 INFO - Running pre-action listener: _resource_record_pre_action 19:56:19 INFO - Running main action method: download_and_extract 19:56:19 INFO - mkdir: /builds/slave/test/build/tests 19:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:19 INFO - https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:56:24 INFO - Downloaded 1361 bytes. 19:56:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:56:24 INFO - Using the following test package requirements: 19:56:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:56:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:56:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'jsshell-linux-x86_64.zip'], 19:56:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:56:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:56:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:56:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:56:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:56:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:56:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:56:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:24 INFO - https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:56:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:56:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:56:29 INFO - Downloaded 24463477 bytes. 19:56:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:56:30 INFO - Return code: 0 19:56:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:30 INFO - https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:56:40 INFO - Downloaded 24463477 bytes. 19:56:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:56:42 INFO - Return code: 0 19:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:42 INFO - https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:56:45 INFO - Downloaded 10833377 bytes. 19:56:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:56:45 INFO - Return code: 0 19:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:45 INFO - https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:56:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:56:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:56:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:56:46 INFO - Downloaded 59348748 bytes. 19:56:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:56:46 INFO - mkdir: /builds/slave/test/properties 19:56:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:56:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:56:46 INFO - Contents: 19:56:46 INFO - build_url:https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:56:47 INFO - Running post-action listener: _resource_record_post_action 19:56:47 INFO - Running post-action listener: set_extra_try_arguments 19:56:47 INFO - ##### 19:56:47 INFO - ##### Finished download-and-extract step (success) 19:56:47 INFO - ##### 19:56:47 INFO - ##### 19:56:47 INFO - ##### Running populate-webroot step. 19:56:47 INFO - ##### 19:56:47 INFO - Running pre-action listener: _resource_record_pre_action 19:56:47 INFO - Running main action method: populate_webroot 19:56:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:56:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:56:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:56:47 INFO - '--tppagecycles', 19:56:47 INFO - '7'], 19:56:47 INFO - 'tests': ['tsvgm']}}, 19:56:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:56:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:56:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:56:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:56:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['damp', 'tps']}, 19:56:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'tests': ['damp', 'tps']}, 19:56:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['dromaeo_dom']}, 19:56:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:56:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['a11yr', 19:56:47 INFO - 'ts_paint', 19:56:47 INFO - 'tpaint', 19:56:47 INFO - 'sessionrestore', 19:56:47 INFO - 'sessionrestore_no_auto_restore', 19:56:47 INFO - 'tabpaint']}, 19:56:47 INFO - 'other-e10s': {'tests': ['a11yr', 19:56:47 INFO - 'ts_paint', 19:56:47 INFO - 'tpaint', 19:56:47 INFO - 'sessionrestore', 19:56:47 INFO - 'sessionrestore_no_auto_restore', 19:56:47 INFO - 'tabpaint']}, 19:56:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:56:47 INFO - 'ts_paint', 19:56:47 INFO - 'tpaint', 19:56:47 INFO - 'sessionrestore', 19:56:47 INFO - 'sessionrestore_no_auto_restore', 19:56:47 INFO - 'tabpaint']}, 19:56:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:56:47 INFO - 'ts_paint', 19:56:47 INFO - 'tpaint', 19:56:47 INFO - 'sessionrestore', 19:56:47 INFO - 'sessionrestore_no_auto_restore', 19:56:47 INFO - 'tabpaint']}, 19:56:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['a11yr', 19:56:47 INFO - 'ts_paint', 19:56:47 INFO - 'tpaint', 19:56:47 INFO - 'sessionrestore', 19:56:47 INFO - 'sessionrestore_no_auto_restore', 19:56:47 INFO - 'tabpaint']}, 19:56:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['a11yr', 19:56:47 INFO - 'ts_paint', 19:56:47 INFO - 'tpaint', 19:56:47 INFO - 'sessionrestore', 19:56:47 INFO - 'sessionrestore_no_auto_restore', 19:56:47 INFO - 'tabpaint']}, 19:56:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['tsvgx', 19:56:47 INFO - 'tsvgr_opacity', 19:56:47 INFO - 'tart', 19:56:47 INFO - 'tscrollx', 19:56:47 INFO - 'cart']}, 19:56:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:56:47 INFO - 'tsvgr_opacity', 19:56:47 INFO - 'tart', 19:56:47 INFO - 'tscrollx', 19:56:47 INFO - 'cart']}, 19:56:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'talos_options': ['--disable-e10s'], 19:56:47 INFO - 'tests': ['tp5o']}, 19:56:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'tests': ['tp5o']}, 19:56:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'talos_options': ['--disable-e10s', 19:56:47 INFO - '--xperf_path', 19:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:47 INFO - 'tests': ['tp5n']}, 19:56:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:47 INFO - 'talos_options': ['--xperf_path', 19:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:47 INFO - 'tests': ['tp5n']}}, 19:56:47 INFO - 'talos.zip': {'path': '', 19:56:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:56:47 INFO - Running post-action listener: _resource_record_post_action 19:56:47 INFO - ##### 19:56:47 INFO - ##### Finished populate-webroot step (success) 19:56:47 INFO - ##### 19:56:47 INFO - ##### 19:56:47 INFO - ##### Running create-virtualenv step. 19:56:47 INFO - ##### 19:56:47 INFO - Running pre-action listener: _resource_record_pre_action 19:56:47 INFO - Running main action method: create_virtualenv 19:56:47 INFO - Creating virtualenv /builds/slave/test/build/venv 19:56:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:56:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:56:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:56:47 INFO - Using real prefix '/usr' 19:56:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:56:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:56:50 INFO - Installing pip.................done. 19:56:50 INFO - Return code: 0 19:56:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:56:50 INFO - Using env: {'DISPLAY': ':0', 19:56:50 INFO - 'HOME': '/home/cltbld', 19:56:50 INFO - 'LANG': 'en_US.UTF-8', 19:56:50 INFO - 'LANGUAGE': 'en_US:en', 19:56:50 INFO - 'LOGNAME': 'cltbld', 19:56:50 INFO - 'MAIL': '/var/mail/cltbld', 19:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:50 INFO - 'MOZ_NO_REMOTE': '1', 19:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:50 INFO - 'NO_EM_RESTART': '1', 19:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:50 INFO - 'PWD': '/builds/slave/test', 19:56:50 INFO - 'SHELL': '/bin/bash', 19:56:50 INFO - 'SHLVL': '1', 19:56:50 INFO - 'TERM': 'linux', 19:56:50 INFO - 'TMOUT': '86400', 19:56:50 INFO - 'USER': 'cltbld', 19:56:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:50 INFO - '_': '/tools/buildbot/bin/python'} 19:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:56:50 INFO - Cleaning up... 19:56:50 INFO - Return code: 0 19:56:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:56:50 INFO - Using env: {'DISPLAY': ':0', 19:56:50 INFO - 'HOME': '/home/cltbld', 19:56:50 INFO - 'LANG': 'en_US.UTF-8', 19:56:50 INFO - 'LANGUAGE': 'en_US:en', 19:56:50 INFO - 'LOGNAME': 'cltbld', 19:56:50 INFO - 'MAIL': '/var/mail/cltbld', 19:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:50 INFO - 'MOZ_NO_REMOTE': '1', 19:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:50 INFO - 'NO_EM_RESTART': '1', 19:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:50 INFO - 'PWD': '/builds/slave/test', 19:56:50 INFO - 'SHELL': '/bin/bash', 19:56:50 INFO - 'SHLVL': '1', 19:56:50 INFO - 'TERM': 'linux', 19:56:50 INFO - 'TMOUT': '86400', 19:56:50 INFO - 'USER': 'cltbld', 19:56:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:50 INFO - '_': '/tools/buildbot/bin/python'} 19:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:50 INFO - Downloading/unpacking psutil>=3.1.1 19:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:52 INFO - Installing collected packages: psutil 19:56:52 INFO - Running setup.py install for psutil 19:56:52 INFO - building 'psutil._psutil_linux' extension 19:56:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:56:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:56:53 INFO - building 'psutil._psutil_posix' extension 19:56:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:56:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:56:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:53 INFO - Successfully installed psutil 19:56:53 INFO - Cleaning up... 19:56:53 INFO - Return code: 0 19:56:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:56:53 INFO - Using env: {'DISPLAY': ':0', 19:56:53 INFO - 'HOME': '/home/cltbld', 19:56:53 INFO - 'LANG': 'en_US.UTF-8', 19:56:53 INFO - 'LANGUAGE': 'en_US:en', 19:56:53 INFO - 'LOGNAME': 'cltbld', 19:56:53 INFO - 'MAIL': '/var/mail/cltbld', 19:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:53 INFO - 'MOZ_NO_REMOTE': '1', 19:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:53 INFO - 'NO_EM_RESTART': '1', 19:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:53 INFO - 'PWD': '/builds/slave/test', 19:56:53 INFO - 'SHELL': '/bin/bash', 19:56:53 INFO - 'SHLVL': '1', 19:56:53 INFO - 'TERM': 'linux', 19:56:53 INFO - 'TMOUT': '86400', 19:56:53 INFO - 'USER': 'cltbld', 19:56:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:53 INFO - '_': '/tools/buildbot/bin/python'} 19:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:56:55 INFO - Installing collected packages: mozsystemmonitor 19:56:55 INFO - Running setup.py install for mozsystemmonitor 19:56:55 INFO - Successfully installed mozsystemmonitor 19:56:55 INFO - Cleaning up... 19:56:55 INFO - Return code: 0 19:56:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:56:55 INFO - Using env: {'DISPLAY': ':0', 19:56:55 INFO - 'HOME': '/home/cltbld', 19:56:55 INFO - 'LANG': 'en_US.UTF-8', 19:56:55 INFO - 'LANGUAGE': 'en_US:en', 19:56:55 INFO - 'LOGNAME': 'cltbld', 19:56:55 INFO - 'MAIL': '/var/mail/cltbld', 19:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:55 INFO - 'MOZ_NO_REMOTE': '1', 19:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:55 INFO - 'NO_EM_RESTART': '1', 19:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:55 INFO - 'PWD': '/builds/slave/test', 19:56:55 INFO - 'SHELL': '/bin/bash', 19:56:55 INFO - 'SHLVL': '1', 19:56:55 INFO - 'TERM': 'linux', 19:56:55 INFO - 'TMOUT': '86400', 19:56:55 INFO - 'USER': 'cltbld', 19:56:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:55 INFO - '_': '/tools/buildbot/bin/python'} 19:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:55 INFO - Downloading/unpacking jsonschema==2.5.1 19:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:57 INFO - warning: no files found matching '*.txt' 19:56:57 INFO - no previously-included directories found matching 'build' 19:56:57 INFO - no previously-included directories found matching 'dist' 19:56:57 INFO - no previously-included directories found matching '.git*' 19:56:57 INFO - Installing collected packages: jsonschema, functools32 19:56:58 INFO - Running setup.py install for functools32 19:56:58 INFO - warning: no files found matching '*.txt' 19:56:58 INFO - no previously-included directories found matching 'build' 19:56:58 INFO - no previously-included directories found matching 'dist' 19:56:58 INFO - no previously-included directories found matching '.git*' 19:56:58 INFO - Successfully installed jsonschema functools32 19:56:58 INFO - Cleaning up... 19:56:58 INFO - Return code: 0 19:56:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:56:58 INFO - Using env: {'DISPLAY': ':0', 19:56:58 INFO - 'HOME': '/home/cltbld', 19:56:58 INFO - 'LANG': 'en_US.UTF-8', 19:56:58 INFO - 'LANGUAGE': 'en_US:en', 19:56:58 INFO - 'LOGNAME': 'cltbld', 19:56:58 INFO - 'MAIL': '/var/mail/cltbld', 19:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:58 INFO - 'MOZ_NO_REMOTE': '1', 19:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:58 INFO - 'NO_EM_RESTART': '1', 19:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:58 INFO - 'PWD': '/builds/slave/test', 19:56:58 INFO - 'SHELL': '/bin/bash', 19:56:58 INFO - 'SHLVL': '1', 19:56:58 INFO - 'TERM': 'linux', 19:56:58 INFO - 'TMOUT': '86400', 19:56:58 INFO - 'USER': 'cltbld', 19:56:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:58 INFO - '_': '/tools/buildbot/bin/python'} 19:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:57:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:57:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:00 INFO - Downloading docopt-0.6.1.tar.gz 19:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:57:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:57:01 INFO - Running setup.py install for blobuploader 19:57:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:57:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:57:01 INFO - Running setup.py install for requests 19:57:01 INFO - Running setup.py install for docopt 19:57:01 INFO - Successfully installed blobuploader requests docopt 19:57:01 INFO - Cleaning up... 19:57:01 INFO - Return code: 0 19:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:57:01 INFO - Using env: {'DISPLAY': ':0', 19:57:01 INFO - 'HOME': '/home/cltbld', 19:57:01 INFO - 'LANG': 'en_US.UTF-8', 19:57:01 INFO - 'LANGUAGE': 'en_US:en', 19:57:01 INFO - 'LOGNAME': 'cltbld', 19:57:01 INFO - 'MAIL': '/var/mail/cltbld', 19:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:01 INFO - 'MOZ_NO_REMOTE': '1', 19:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:01 INFO - 'NO_EM_RESTART': '1', 19:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:01 INFO - 'PWD': '/builds/slave/test', 19:57:01 INFO - 'SHELL': '/bin/bash', 19:57:01 INFO - 'SHLVL': '1', 19:57:01 INFO - 'TERM': 'linux', 19:57:01 INFO - 'TMOUT': '86400', 19:57:01 INFO - 'USER': 'cltbld', 19:57:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:01 INFO - '_': '/tools/buildbot/bin/python'} 19:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:01 INFO - Running setup.py (path:/tmp/pip-JHcvKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:01 INFO - Running setup.py (path:/tmp/pip-C16kTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:02 INFO - Running setup.py (path:/tmp/pip-AFhQLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:02 INFO - Running setup.py (path:/tmp/pip-Bt7NQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:02 INFO - Running setup.py (path:/tmp/pip-m5WKzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:02 INFO - Running setup.py (path:/tmp/pip-4MGQWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:02 INFO - Running setup.py (path:/tmp/pip-77qFPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:02 INFO - Running setup.py (path:/tmp/pip-P0vVvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:02 INFO - Running setup.py (path:/tmp/pip-2ZqDL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:02 INFO - Running setup.py (path:/tmp/pip-OjxZyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:02 INFO - Running setup.py (path:/tmp/pip-FGwlEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:02 INFO - Running setup.py (path:/tmp/pip-wIkMXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:02 INFO - Running setup.py (path:/tmp/pip-JK2l7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:02 INFO - Running setup.py (path:/tmp/pip-3Y_HlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:02 INFO - Running setup.py (path:/tmp/pip-bgLahX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:02 INFO - Running setup.py (path:/tmp/pip-Ps7oSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:03 INFO - Running setup.py (path:/tmp/pip-TRT6bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:57:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:57:03 INFO - Running setup.py install for manifestparser 19:57:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Running setup.py install for mozcrash 19:57:03 INFO - Running setup.py install for mozdebug 19:57:03 INFO - Running setup.py install for mozdevice 19:57:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Running setup.py install for mozfile 19:57:03 INFO - Running setup.py install for mozhttpd 19:57:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Running setup.py install for mozinfo 19:57:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Running setup.py install for mozInstall 19:57:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:57:03 INFO - Running setup.py install for mozleak 19:57:04 INFO - Running setup.py install for mozlog 19:57:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:57:04 INFO - Running setup.py install for moznetwork 19:57:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:57:04 INFO - Running setup.py install for mozprocess 19:57:04 INFO - Running setup.py install for mozprofile 19:57:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:57:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:57:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:57:04 INFO - Running setup.py install for mozrunner 19:57:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:57:04 INFO - Running setup.py install for mozscreenshot 19:57:04 INFO - Running setup.py install for moztest 19:57:04 INFO - Running setup.py install for mozversion 19:57:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:57:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:57:04 INFO - Cleaning up... 19:57:04 INFO - Return code: 0 19:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:57:04 INFO - Using env: {'DISPLAY': ':0', 19:57:04 INFO - 'HOME': '/home/cltbld', 19:57:04 INFO - 'LANG': 'en_US.UTF-8', 19:57:04 INFO - 'LANGUAGE': 'en_US:en', 19:57:04 INFO - 'LOGNAME': 'cltbld', 19:57:04 INFO - 'MAIL': '/var/mail/cltbld', 19:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:04 INFO - 'MOZ_NO_REMOTE': '1', 19:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:04 INFO - 'NO_EM_RESTART': '1', 19:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:04 INFO - 'PWD': '/builds/slave/test', 19:57:04 INFO - 'SHELL': '/bin/bash', 19:57:04 INFO - 'SHLVL': '1', 19:57:04 INFO - 'TERM': 'linux', 19:57:04 INFO - 'TMOUT': '86400', 19:57:04 INFO - 'USER': 'cltbld', 19:57:04 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:04 INFO - '_': '/tools/buildbot/bin/python'} 19:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:57:05 INFO - Running setup.py (path:/tmp/pip-wJurl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:57:05 INFO - Running setup.py (path:/tmp/pip-uMTMlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:57:05 INFO - Running setup.py (path:/tmp/pip-OulPss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:57:05 INFO - Running setup.py (path:/tmp/pip-yJQUtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:57:05 INFO - Running setup.py (path:/tmp/pip-tesQ8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:57:05 INFO - Running setup.py (path:/tmp/pip-_YlvJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:57:05 INFO - Running setup.py (path:/tmp/pip-wytdOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:57:05 INFO - Running setup.py (path:/tmp/pip-r7jc_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:57:05 INFO - Running setup.py (path:/tmp/pip-WA6u1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:57:05 INFO - Running setup.py (path:/tmp/pip-tS1yCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:57:05 INFO - Running setup.py (path:/tmp/pip-tMt06o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:57:05 INFO - Running setup.py (path:/tmp/pip-OArbpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:57:05 INFO - Running setup.py (path:/tmp/pip-YpY_s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:57:06 INFO - Running setup.py (path:/tmp/pip-GxtMql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:06 INFO - Running setup.py (path:/tmp/pip-sSpy1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:57:06 INFO - Running setup.py (path:/tmp/pip-LGafYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:57:06 INFO - Running setup.py (path:/tmp/pip-0w4hJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:57:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:08 INFO - Downloading blessings-1.6.tar.gz 19:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:57:08 INFO - Installing collected packages: blessings 19:57:08 INFO - Running setup.py install for blessings 19:57:08 INFO - Successfully installed blessings 19:57:08 INFO - Cleaning up... 19:57:08 INFO - Return code: 0 19:57:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:57:08 INFO - Reading from file tmpfile_stdout 19:57:08 INFO - Current package versions: 19:57:08 INFO - argparse == 1.2.1 19:57:08 INFO - blessings == 1.6 19:57:08 INFO - blobuploader == 1.2.4 19:57:08 INFO - docopt == 0.6.1 19:57:08 INFO - functools32 == 3.2.3-2 19:57:08 INFO - jsonschema == 2.5.1 19:57:08 INFO - manifestparser == 1.1 19:57:08 INFO - mozInstall == 1.12 19:57:08 INFO - mozcrash == 0.17 19:57:08 INFO - mozdebug == 0.1 19:57:08 INFO - mozdevice == 0.48 19:57:08 INFO - mozfile == 1.2 19:57:08 INFO - mozhttpd == 0.7 19:57:08 INFO - mozinfo == 0.9 19:57:08 INFO - mozleak == 0.1 19:57:08 INFO - mozlog == 3.2 19:57:08 INFO - moznetwork == 0.27 19:57:08 INFO - mozprocess == 0.22 19:57:08 INFO - mozprofile == 0.28 19:57:08 INFO - mozrunner == 6.11 19:57:08 INFO - mozscreenshot == 0.1 19:57:08 INFO - mozsystemmonitor == 0.3 19:57:08 INFO - moztest == 0.7 19:57:08 INFO - mozversion == 1.4 19:57:08 INFO - psutil == 3.1.1 19:57:08 INFO - requests == 1.2.3 19:57:08 INFO - wsgiref == 0.1.2 19:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:57:08 INFO - Using env: {'DISPLAY': ':0', 19:57:08 INFO - 'HOME': '/home/cltbld', 19:57:08 INFO - 'LANG': 'en_US.UTF-8', 19:57:08 INFO - 'LANGUAGE': 'en_US:en', 19:57:08 INFO - 'LOGNAME': 'cltbld', 19:57:08 INFO - 'MAIL': '/var/mail/cltbld', 19:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:08 INFO - 'MOZ_NO_REMOTE': '1', 19:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:08 INFO - 'NO_EM_RESTART': '1', 19:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:08 INFO - 'PWD': '/builds/slave/test', 19:57:08 INFO - 'SHELL': '/bin/bash', 19:57:08 INFO - 'SHLVL': '1', 19:57:08 INFO - 'TERM': 'linux', 19:57:08 INFO - 'TMOUT': '86400', 19:57:08 INFO - 'USER': 'cltbld', 19:57:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:08 INFO - '_': '/tools/buildbot/bin/python'} 19:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:57:08 INFO - Cleaning up... 19:57:08 INFO - Return code: 0 19:57:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:57:08 INFO - Using env: {'DISPLAY': ':0', 19:57:08 INFO - 'HOME': '/home/cltbld', 19:57:08 INFO - 'LANG': 'en_US.UTF-8', 19:57:08 INFO - 'LANGUAGE': 'en_US:en', 19:57:08 INFO - 'LOGNAME': 'cltbld', 19:57:08 INFO - 'MAIL': '/var/mail/cltbld', 19:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:08 INFO - 'MOZ_NO_REMOTE': '1', 19:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:08 INFO - 'NO_EM_RESTART': '1', 19:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:08 INFO - 'PWD': '/builds/slave/test', 19:57:08 INFO - 'SHELL': '/bin/bash', 19:57:08 INFO - 'SHLVL': '1', 19:57:08 INFO - 'TERM': 'linux', 19:57:08 INFO - 'TMOUT': '86400', 19:57:08 INFO - 'USER': 'cltbld', 19:57:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:08 INFO - '_': '/tools/buildbot/bin/python'} 19:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:57:09 INFO - Cleaning up... 19:57:09 INFO - Return code: 0 19:57:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f463ff3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2987190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:57:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:57:09 INFO - Using env: {'DISPLAY': ':0', 19:57:09 INFO - 'HOME': '/home/cltbld', 19:57:09 INFO - 'LANG': 'en_US.UTF-8', 19:57:09 INFO - 'LANGUAGE': 'en_US:en', 19:57:09 INFO - 'LOGNAME': 'cltbld', 19:57:09 INFO - 'MAIL': '/var/mail/cltbld', 19:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:09 INFO - 'MOZ_NO_REMOTE': '1', 19:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:09 INFO - 'NO_EM_RESTART': '1', 19:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:09 INFO - 'PWD': '/builds/slave/test', 19:57:09 INFO - 'SHELL': '/bin/bash', 19:57:09 INFO - 'SHLVL': '1', 19:57:09 INFO - 'TERM': 'linux', 19:57:09 INFO - 'TMOUT': '86400', 19:57:09 INFO - 'USER': 'cltbld', 19:57:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:09 INFO - '_': '/tools/buildbot/bin/python'} 19:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:09 INFO - Downloading/unpacking flake8 19:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:57:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:57:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:11 INFO - no previously-included directories found matching 'docs/_build' 19:57:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:57:12 INFO - Running setup.py install for pep8 19:57:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:57:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:57:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:57:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:57:12 INFO - no previously-included directories found matching 'docs/_build' 19:57:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:57:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:57:12 INFO - Cleaning up... 19:57:12 INFO - Return code: 0 19:57:12 INFO - Running post-action listener: _resource_record_post_action 19:57:12 INFO - Running post-action listener: _start_resource_monitoring 19:57:12 INFO - Starting resource monitoring. 19:57:12 INFO - ##### 19:57:12 INFO - ##### Finished create-virtualenv step (success) 19:57:12 INFO - ##### 19:57:12 INFO - ##### 19:57:12 INFO - ##### Running install step. 19:57:12 INFO - ##### 19:57:12 INFO - Running pre-action listener: _resource_record_pre_action 19:57:12 INFO - Running main action method: install 19:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:57:12 INFO - Reading from file tmpfile_stdout 19:57:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:57:12 INFO - Reading from file tmpfile_stdout 19:57:12 INFO - Output received: 19:57:12 INFO - Usage: mozinstall [options] installer 19:57:12 INFO - Options: 19:57:12 INFO - -h, --help show this help message and exit 19:57:12 INFO - -d DEST, --destination=DEST 19:57:12 INFO - Directory to install application into. [default: 19:57:12 INFO - "/builds/slave/test"] 19:57:12 INFO - --app=APP Application being installed. [default: firefox] 19:57:12 INFO - mkdir: /builds/slave/test/build/application 19:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:57:29 INFO - Reading from file tmpfile_stdout 19:57:29 INFO - Output received: 19:57:29 INFO - /builds/slave/test/build/application/firefox/firefox 19:57:29 INFO - Running post-action listener: _resource_record_post_action 19:57:29 INFO - ##### 19:57:29 INFO - ##### Finished install step (success) 19:57:29 INFO - ##### 19:57:29 INFO - ##### 19:57:29 INFO - ##### Running run-tests step. 19:57:29 INFO - ##### 19:57:29 INFO - Running pre-action listener: _resource_record_pre_action 19:57:29 INFO - Running main action method: run_tests 19:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:57:29 INFO - Python 2.7.3 19:57:29 INFO - Return code: 0 19:57:29 INFO - grabbing minidump binary from tooltool 19:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a19110>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2985230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29856c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:57:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:57:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:57:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:57:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:57:29 INFO - Return code: 0 19:57:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:57:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:57:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:57:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:57:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:57:30 INFO - Return code: 0 19:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:57:30 INFO - Using env: {'DISPLAY': ':0', 19:57:30 INFO - 'HOME': '/home/cltbld', 19:57:30 INFO - 'LANG': 'en_US.UTF-8', 19:57:30 INFO - 'LANGUAGE': 'en_US:en', 19:57:30 INFO - 'LOGNAME': 'cltbld', 19:57:30 INFO - 'MAIL': '/var/mail/cltbld', 19:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:30 INFO - 'MOZ_NO_REMOTE': '1', 19:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:30 INFO - 'NO_EM_RESTART': '1', 19:57:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:30 INFO - 'PWD': '/builds/slave/test', 19:57:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:57:30 INFO - 'SHELL': '/bin/bash', 19:57:30 INFO - 'SHLVL': '1', 19:57:30 INFO - 'TERM': 'linux', 19:57:30 INFO - 'TMOUT': '86400', 19:57:30 INFO - 'USER': 'cltbld', 19:57:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465612445.995203-1538470066', 19:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:30 INFO - '_': '/tools/buildbot/bin/python'} 19:57:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:57:30 INFO - mozversion application_buildid: 20160610173004 19:57:30 INFO - mozversion application_changeset: 618a8336136754762b1002f9838fa574ffc60937 19:57:30 INFO - mozversion application_display_name: Nightly 19:57:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:57:30 INFO - mozversion application_name: Firefox 19:57:30 INFO - mozversion application_remotingname: firefox 19:57:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:57:30 INFO - mozversion application_vendor: Mozilla 19:57:30 INFO - mozversion application_version: 50.0a1 19:57:30 INFO - mozversion platform_buildid: 20160610173004 19:57:30 INFO - mozversion platform_changeset: 618a8336136754762b1002f9838fa574ffc60937 19:57:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:57:30 INFO - mozversion platform_version: 50.0a1 19:57:30 INFO - using testdate: 1465613850 19:57:30 INFO - actual date: 1465613850 19:57:30 INFO - starting webserver on 'localhost:45121' 19:57:30 INFO - SUITE-START | Running 2 tests 19:57:30 INFO - TEST-START | dromaeo_css 19:57:30 INFO - operating with platform_type : linux_ 19:57:30 INFO - Initialising browser for dromaeo_css test... 19:57:30 INFO - TEST-INFO | started process 25033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDyWb0/profile http://localhost:45121/getInfo.html) 19:57:35 INFO - PROCESS | 25033 | __metrics Screen width/height:1600/1200 19:57:35 INFO - PROCESS | 25033 | colorDepth:24 19:57:35 INFO - PROCESS | 25033 | Browser inner width/height: 1024/697 19:57:35 INFO - PROCESS | 25033 | __metrics 19:57:36 INFO - PROCESS | 25033 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:36 INFO - PROCESS | 25033 | console.error: PushService: 19:57:36 INFO - PROCESS | 25033 | stateChangeProcessEnqueue: Error transitioning state 19:57:36 INFO - PROCESS | 25033 | UnknownError 19:57:37 INFO - TEST-INFO | 25033: exit 0 19:57:37 INFO - Browser initialized. 19:57:37 INFO - Running cycle 1/1 for dromaeo_css test... 19:57:37 INFO - TEST-INFO | started process 25114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphDyWb0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:49 INFO - PROCESS | 25114 | RSS: Main: 174051328 19:57:49 INFO - PROCESS | 25114 | 19:58:40 INFO - PROCESS | 25114 | 1465613920479 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:00:48 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:45121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45121/tests/dromaeo/cssquery-ext.html) 20:00:49 INFO - PROCESS | 25114 | RSS: Main: 247685120 20:00:49 INFO - PROCESS | 25114 | 20:03:52 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:45121/tests/dromaeo/cssquery-ext.html (next: http://localhost:45121/tests/dromaeo/cssquery-jquery.html) 20:03:52 INFO - PROCESS | 25114 | RSS: Main: 253874176 20:03:52 INFO - PROCESS | 25114 | 20:06:54 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:45121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45121/tests/dromaeo/cssquery-mootools.html) 20:06:55 INFO - PROCESS | 25114 | RSS: Main: 269193216 20:06:55 INFO - PROCESS | 25114 | 20:09:57 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:45121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45121/tests/dromaeo/cssquery-prototype.html) 20:09:58 INFO - PROCESS | 25114 | RSS: Main: 258306048 20:09:58 INFO - PROCESS | 25114 | 20:13:00 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:45121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45121/tests/dromaeo/cssquery-yui.html) 20:13:01 INFO - PROCESS | 25114 | RSS: Main: 221433856 20:13:01 INFO - PROCESS | 25114 | 20:16:03 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:45121/tests/dromaeo/cssquery-yui.html (next: http://localhost:45121/tests/dromaeo/cssquery-dojo.html) 20:16:04 INFO - PROCESS | 25114 | RSS: Main: 287338496 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | __start_tp_report 20:16:04 INFO - PROCESS | 25114 | _x_x_mozilla_page_load 20:16:04 INFO - PROCESS | 25114 | _x_x_mozilla_page_load_details 20:16:04 INFO - PROCESS | 25114 | |i|pagename|runs| 20:16:04 INFO - PROCESS | 25114 | |0;dojo.html;3066.8926587569426;3078.091962870953;3100.1164668069596;3122.516010018448;3130.89041883534;5183.352080989876;5269.394019687737;5271.15661494161;5371.731413429327;5390.676559406438;5256.027634887549;5349.652272602288;5375.086235339992;5403.864903377417;5504.394516603171;4743.12252233337;4807.375041244651;4822.373091498101;4839.716593172482;4889.33993910821;4912.656114072016;4980.203167493201;4985.07776061428;4991.875203119915;5029.3964724232965;4711.976440117812;4745.667803253739;4746.52534746526;4940.777665005084;4961.156603377416;4818.879528011793;4819.855404337875;4819.855404337875;4820.421549414093;4820.879478013043;4779.617630589544;4796.616270698336;4800.303955926406;4856.902861942742;4942.827001054981;5371.704556249405;5376.193570964348;5396.514313711785;5423.484768946943;5432.75552600134;5761.827145185609;5763.971180144114;5804.419558044162;5807.506361959238;5812.360640329561;5489.094299440588;5541.750621222055;5544.16837474378;5569.832905012856;5640.689762063085;5212.556932660728;5242.9213561796605;5244.763985620618;5280.788768449257;5316.175992721134;5733.541316694655;5760.769569217268;5783.277090363705;5784.132380143013;5785.4214578541805;5534.695591742412;5569.693666848362;5584.162375643605;5588.050031494656;5589.636673616202;5465.890682186334;5678.517326027334;5716.714164291769;5719.714014299351;5772.3938986406665;5699.829005129853;5708.457696518824;5714.7428365723645;5718;5720.771169153188;5417.891642167135;5729.914051289234;5731.799387021434;5736.68448235351;5737.3115226172295;4216.219999300078;4352.281873490839;4376.562343765598;4408.140412619572;4430.734155950653;3929.2927273090545;3936.980315098406;3939.1136994176654;3951.091249012743;3973.4834471518516;5314.0700377433795;5380.946190538123;5432.076546987022;5439.891202175934;5441.075017247077;5762.74067666956;5804.506616937523;5839.270091238595;5840.707964601753;5883.294004719461;5440.102383106822;5468.207109969112;5470.890582188334;5471.972640136773;5472.069748142825;4912.729799861042;4961;4993.525615066563;5017.297578339036;5073.188289873602;5965.13505541694;5970.582059255898;5973.104034394789;5976.073708575178;6018.337982821886;5804.245448091721;5806.622569532967;5818.534517238695;5819.388964158702;5822.475977162076;5763.567732420001;5772.6536407815665;5807.622504537191;5845.590808643354;5961.433663802105;5652.547796176378;5654.773809047757;5662.85842853932;5663.093904975184;5664.886702266014;5656.43435656431;5663.801766938137;5695.829125126253;5712.400197979152;5713.628614140068;5470.425605311544;5497.615166938276;5518.034343989866;5549.972250138723;5577.330720313588;5492.945070549403;5497.862553436036;5512.751926163252;5546.389897111395;5562.749676264497;5328.413874473727;5433.782648694008;5439.537639300545;5448.046591846491;5487.122060470306;5390.407055224001;5535.640183388067;5572.582056345709;5604.075327570905;5609.5512359012;5434.157705555645;5457.372402173801;5534.750936207961;5538.307711536058;5539.7784088636 20:16:04 INFO - PROCESS | 25114 | |1;ext.html;601.0953514959984;617.7961272779983;629.442942995449;638.639168869589;642.8553575445524;30606.38787224257;31194.688053119462;43314.783426082824;43660.78169609147;43801.342979855326;40281;44756;44764;44919;44929.7753511232;8780.956095219532;8909.866352004725;8925.687600933968;8931;8931.106889311082;8658.48049117055;8757.124287571256;8764.43031202973;8764.737057888242;8764.868526972068;8760.342974276955;8810.823783524358;8814.603342849556;8815.382923195379;8817;8722.956385218065;8789;8789.956050219773;8790.384673072887;8792.34057445691;8684.652613895436;8776.341774366949;8791.032986371494;8793.516356600385;8795.604197811113;41464;41615.167696646204;41834;41892.79053604743;41905.58094419047;3557.484164796116;3617.782933024027;3650.995976106565;3683.907902302437;3684.171061511165;32050.679493205236;32637.184070398194;32754.6724532754;32773.18067048319;33051.504227436366;3966.3852102923806;4015.7791321477307;4033.2740106780766;4071.75569465833;4143.212789570002;361043;365137;365540;367352.16323918477;367594;58616;61182;62186.689066555286;62194;62212.68893655503;62880.685596571726;64339.67830160819;64443;69841;69901;15966.680666386606;16018;16070.598235044217;16140.515784526482;16142.435014774426;11206.215564910379;11374.31754094757;11410.657680269605;11480.885191148149;11493.367864767351;17836.019018953823;19195.520111997314;19558.5110372239;19582.804171958098;19587.11857966395;6951.304869513109;6982.47631427645;7001.264867188974;7046.6476676165985;7263.3826124778925;1009.7627057641448;1019.7093828258911;1051.6476980211714;1117.1118960426481;1135.625243669587;32770.67229327724;32791.67208327886;32797.508037379455;33091;33204.68711044627;1106.5684383090602;1132.3432409202642;1146.7534480086822;1156.5720683347215;1177.8645455772696;16266.349346026263;16916.238769255415;17234.396796112076;17404.39084632032;17457.825421745874;550399;551541;552572;553252;554193;57052.71473642688;57826.7108664454;57884.13173802396;57976;57987;1266.4554241676167;1358.076507974567;1368.8152099466445;1394.2540740703676;1396.057661078788;32102.839485802422;33637.66362336443;34001.82999084989;34093.488597670555;34490.48264276088;50010.249846253064;50533.49466505288;50540.74729626328;50626;50664.74667626786;387555;388448;388862;389343;390004;23744.88127559351;27901;27936.580951286152;28825.711742882304;29110.708892911647;47775.5222447785;48417.27374089321;48437.757811210715;48561.27158092702;49845;40564.3915341276;41368.586314136475;41488.58511414968;41696.79151604223;42471.362929555464;39512;40476.3928541078;40843.795781020905;41068.383974241005;41376.79311603423;39628.405573915836;40551.391729124676;41152.38271425871;41161.38257926193;41205;34642.82678586591;35695;36128;37030.25939481249;37096;25202.873985629954;25444.618330724683;25565.488690226462;25803.741962580134;25871 20:16:04 INFO - PROCESS | 25114 | |2;jquery.html;395.3575439910146;400.87572852415735;400.98396064157436;401.3117503481529;423.23394655673235;13752.381142848571;16346.34614615414;17575.472735817915;18985.240590376387;18986.05069746512;14547.636309092279;15098.849011509908;17334.739978900325;17675.381361652344;17690.557736056606;5418.564080518656;5423.996560636275;5648.124540696178;5689.402612725667;5737.827865164031;5709.914351284734;5716.942830571704;5733.627314224562;5759.424057594249;5765.509931655814;3779.4708740776314;6859.2454829968665;7199.424046076301;7201.459890508207;7205.063341765589;7071.1868135164605;7089.893651595205;7129.714811407537;7279.818004549876;7290.3438690518105;6813.965930170318;6848.657567121624;7008.474364422637;7011.789646310619;7061.1173603299585;25108.874455627603;25466.236012919642;25638.359041023938;25696.357591060187;25702.100426484983;2539.987300063506;2588.4823035392997;2670.252329347766;2886.581445690384;2895.971040289591;15032.549023529311;15064.397424103023;15096.849031509653;15326.540203793904;16025.19874006295;1994.8902810345426;2041.2345370486069;2078.418042947977;2103.1061798735477;2155.8706477611236;69479.65260173718;72143;72548.27451725469;91868;95497;16871.240794164045;17365.479035628952;17399.391021314193;17584.82415175832;17837.502749614803;30842;30956.22609434737;31285.530717039263;31409.214769630486;31421.528677069862;8713.912860871436;8786.209241168197;9239.90760092404;9348.345615806827;10186.745331366776;8187;8213.466124701876;8249.79375515605;8352.707655232038;8389.370797190235;8703.43427677199;8756.211940925346;8869.516535370107;8982.955085224532;9001.819963600823;3477.217626034122;3515.191505953645;3516.7889926604485;3554.662307080823;3686.8156592170285;903.421810041574;968.080323692495;992.161623428202;1016.6616781402892;1016.9186465082776;17269.39557115495;17767.822321776875;17943.820561794477;18871.245150193838;18966.525836853914;973.3089506450358;975.3465178330536;984.8128855517429;993.8757655293089;1051.4479898053582;10026.448545329931;10186.949065254626;10567.471626418648;10717.946410268054;10985;481355;492294;494455;495293;498943;91803.54098229599;97144;99059.50470247747;99178.50410748045;99212.50393747985;1002.9047240512285;1021.371856308365;1031.7059638003284;1043.7912417516527;1046.6807623674852;16263.721029256507;16663;16990.915045424696;17022.233999469805;17093.487195384158;40117.398239027025;40228.39657405083;40589.79705101455;41483.1703365937;41783.98592168959;57212;59006.40993590009;59712.70143649254;60030.69984650049;60728.69635651793;8266.462679925786;8338.833223335378;8467.95766021166;8571.314294856273;8692.391532592657;9468.668596599086;12587.622371328875;12780.297083660116;12844.293563854078;13497.797533036815;7812.140664527011;11100.666979990614;11317;11420.314781112827;11645.825312620149;11015.614453494089;11146.665600032013;11158.10735141203;11170;11218.214724969173;11486.885131148581;11567.537298507965;11696.239744416585;11757.118216133995;12021.81967270509;8443.788905277417;8491.363147764067;8557.44376615518;8629.266512346521;8716;11068.723281918017;11494.367809770543;11516.53933842637;11679;11682.415879206175 20:16:04 INFO - PROCESS | 25114 | |3;mootools.html;1302.1275745250682;1372.1286982765944;1419.063418144025;1507.721071601753;1765.9117044147797;8718.258947989421;9114.54427278636;9141.314401419895;9358.3917045392;9400.294977876652;9028.36801423899;9259.305552083588;9259.6296148154;9276.953615231914;9290.117438843316;2356.9057237710513;2379.690640216769;2380.7382087493656;2381.8928148233285;2382.404398900275;2437.609982402816;2438.5976313908272;2482.255323402972;2490.402303447169;2491.0533997081084;2422.1522467136538;2432.4648577312964;2455.545724041049;2456.5701002324613;2466.851988880664;2329.1615018593293;2331.9650205246935;2336.7429582745885;2340.449994251358;2388.79695225906;2283.977160228393;2353.6116540770754;2359.8230132740114;2364.5152743687504;2366.7396586375485;7813.296803287674;8000.199980002011;9209.493477858716;9292.581833817494;9303.302252331034;5248.21276808478;5433.701146436944;5434.375046869621;5480.424555421703;5496.203050557647;3398.082517720202;3498.4402495600834;3527.1358517163203;3528.9117772055647;3538.097785064818;1155.78040172367;1171.859376874772;1186.5669030803695;1186.7329850783592;1189.8988585970203;12936;13032.54386096482;13057.086003979724;13065.477380904753;13073.477060917647;4757.310190022427;4809.639277054165;4855.417349918032;4855.8057677693205;4961.355023846877;10885.510152043176;10911.618093366695;10934.289271197347;10945.4527273636;10945.83581246266;5475.507204351547;5477;5482.205080263339;5483.396826349099;5486.670799751948;4937.308776771183;4990.101781679333;5064.645474816801;5151.742412879416;5159.690418574823;3776.244751049801;3804.4483549885113;3876.0503676599415;3880.990942355008;3908.2769687607883;1266.9176503527242;1276.8595454499998;1288.890444312244;1301.3103055380664;1304.3347892574666;848.6308455821737;956.2636769687441;1000.7898341348252;1009.1724785675675;1027.5067967375553;6244.1570387997945;6343.5876668016435;6345.841353966188;6354.3645635437015;6417.038206317096;449.35517532340543;456.2107553931651;458.75227377216595;464.46354460598064;470.1372980580604;4085.162541678949;4159.8960025999595;4164.60436258561;4213.431186789805;4224.5353011168745;11098.44507774608;11484.827727584094;11566.30602163873;11579.247348922294;11591.76816463666;11386;11474.598389056342;11532.192746507664;11532.481038353295;11540.538378464935;8269.255766981001;8557;8589.44168629037;8621.180987806149;8673.132686731276;6280.371962803866;6477.352264773485;6516.348365163446;6618.873124120104;6637.037629543785;10470.999999999694;10720.463976801284;10747.677569672922;10916.781664366827;10937.726556836144;10546.736331591772;10767.084797792275;10951.069159121564;10969.286996345212;10970.232083754061;7609.2010338913615;7876.448648594544;7887.1718469562165;8052.597370131587;8096;8713.782155446164;8899.243564297107;9039.864402034107;9050.456972581665;9051.59267832936;7952.721654742057;8009.118996910452;8166.918330816853;8185.508869467851;8264.83470330602;7798.532088074734;7846.882296765439;7862.213778622092;7937.047554293522;7957.562334071682;7059.082319298664;7135.464840136907;7203.459740519377;7253.347198752138;7344.118705755343;4296.806643700978;5384.084705599979;5420.322459692538;5453.672779633234;5653;5417.160340147283;5430.099465187153;5453.400125986218;5466.316710411199;5598.048331783688 20:16:04 INFO - PROCESS | 25114 | |4;prototype.html;319.6739325887595;321.3781333120412;327.2603915151759;328.4236165529495;331.9369319829233;5335.973320133404;5339.199120131977;5342.931413717262;5355.634313250121;5370.43610420906;5249.451411833509;5259.86850328742;5273.551748101407;5280.735963201843;5281.656692314997;3951.486306780115;4117.835286588533;4175.269327867611;4220.451341325624;4222.239996800575;4134.793260336986;4184.916301673965;4187.979060104695;4194.874153775391;4219.472565929259;4158.875233742992;4163.729357591762;4176.624103830654;4178.853740119096;4181.351890456969;4027.2750904837117;4042.3532234842282;4174.833006679729;4176.895577610554;4210.179015092058;3655.5796083450477;3689.631036896316;3692.095436618046;3696.9630303696886;3722.516072910504;5133.922991155136;5137.743112844343;5191.3524102707515;5205.427402985669;5256.316678831728;4528.298113792334;4644.210484217658;4775.976120119377;4794.184988551954;4838.467768545457;5477.370102438231;5540.418256083093;5549.1676248562635;5560.638558493725;5645.30640807756;4069.2065047315787;4080.8979775505554;4116.115035267402;4116.403121547359;4130.524989626201;5633.40849210831;5733.684647344395;5735.971320143414;5759.5968282220265;5814.6511209327155;4093;4138.193052354822;4166.791660416967;4185.58144185579;4206.26390381682;4231.074860938265;4242.342436922282;4246.426732391149;4251.404803327537;4253.680973926906;4617.769111544477;4745.193317136095;4748.169070412733;4809.422869255712;4846.830360937421;5529.3000949192865;5551.528120109755;5558.749856256478;5565.805196818092;5577.414371490935;1435.992820035914;1439.3522914688433;1451.981745373931;1454.8545145485366;1469.0965056490181;924.191332583989;933.9953300233591;940.7412961435523;946.9110522898584;949.8432758594893;4744.501827308152;4768.569429171234;4781.402324709411;4787.994521150597;4819.132556139858;5106.7446627669215;5135.2553879687985;5163.40620828602;5167.715775632301;5198.81804136861;4722.763861806896;4888.706677599355;4923.409190897115;5029.698218106925;5428.728563571805;2915.344047589318;2953.74893134086;3029.242689327668;3052.832094234838;3070.1710538154575;5864.592497800582;5874.853128671817;5890.175375447441;5892.852678683067;5914.556408269397;5581.49766521015;5849.415058494116;5874.559408044413;5878.764849406061;5882.23530940975;5839.357670656224;5880.764769409347;5906.173135760911;5924.496417804448;5955.434233747787;5533.418991005887;5696.487316141567;5720.971395142998;5750.281214848144;5751.971240143773;5585.497305242548;5604.8318550443555;5677.432256774455;5690.630109042899;5733.369329373682;5829.213056237354;5842.649441033552;5882.647041177543;5886.23478947734;5922.911156332572;3880.7387599030994;3955.960440395559;4025.6175663311938;4036.7577945323374;4046.2109888572622;5542.307211598551;5543.972280138735;5661.490465858093;5667.4615911488345;5679.204911312337;5545.833624991256;5552.444755524415;5614.157876318585;5634.211210430461;5649.293838270216;5313.282706834528;5404.510414079656;5466.753996070107;5497.51567076879;5566;5427.755750991294;5453.864028183731;5464.316960379952;5481.205225242397;5491.697956612425;5526.530244929226;5531.502164805187;5543.584231182596;5558.221848941071;5558.49920521465;5169.327987361619;5428.647137936022;5442.156465747816;5442.319710036246;5461.017016936989 20:16:04 INFO - PROCESS | 25114 | |5;yui.html;711.7366574367485;729.8394353242288;751.0229963637804;778.9717572803901;825.352098602597;15007;15848.920755396235;15889.682206355867;15904.284307206175;15929.283182256797;13567.796483052738;13577.932110339434;13646.863531364683;13921.1647301162;14127.223002734845;669.6283562622767;820.3642177312586;825.558326295432;826.017039722728;826.5082276045773;785.681798871458;804.5414113955048;807.7980504873782;810.6028046257321;813.8209593889335;850.421713235;852.2457625001856;855.7689423855555;856.6402111113347;857.0572370392581;707.1726080485844;831.5925196653596;850.3834719828106;850.3877208409934;850.8340873529634;619.4765423217419;619.8667286533417;623.6445226221056;627.0187157099125;627.3130921640796;13658.863411365859;13792.448302067905;13794.172349658953;13990.230537320444;13991.370388332549;14595.489157879529;15448.304826282843;15553.066815991077;15596.61008474786;15797.131157786318;12072.698182545506;12388.504459821595;12404.317762523058;12467.563635272722;12593.488781346205;3889.2999260133447;3931.646151846319;3953.347697629916;4004.3392840181336;4107.835686572534;78674;79688.60155699242;79949;80417.59791201007;80950;11899.226550274205;12095.516179352904;12152.756944861054;12177.573784917662;12306.07704422172;23211;23236.53526929452;23238.3028509145;23252.7674723254;23286.06855725752;8054.59727013647;8301.086880443147;8396.706115285935;8424.663013479392;8656.09111043344;4265.360195970629;4323;4417.182821178092;4513.977430112828;4567.314902764612;3353.2622822978906;3497.842597083137;3503.4219353806848;3505.8948231553095;3510.929781404409;598.7664810723821;614.121805817685;647.3106141958799;654.3293124547282;688.9242183359827;731.2029887422734;749.3443237167478;765.1010063175746;779.3180966654178;785.4384115357547;9571.09802480669;10018.448985305733;10020.198384129251;10062.19270292176;10083.49582520871;636.287358158865;667.846395329077;696.2967402923084;725.1189804387694;742.6296246588756;4559.133764584718;4571.085782843445;4620.584147426748;4679.64902632304;4701.365315682339;120708.39645801715;121824;123661;123725.38137309256;124659.37670311591;81904.59047704842;89718.55140724254;89768;90655;107155.46422267839;80899.19100809035;83069;83461.99228046337;83957;84171.15828841634;10232.386056836614;10302.948485257526;10405.427701476188;10671.786564268827;10724.088452481314;47819;49541.50458495513;50747.746261268454;50769.74615127048;52023;65967.34032659612;74046.62976685082;74337.2566274352;74534.62732686302;74572.62713686397;12842.486300547873;12913.741725165257;13040.282784446947;13121.081524293208;13532.052756306965;14945.476908308157;15500.612484687974;15855.445059422866;15884.92057539705;15910.920445397698;9732.70801875945;13314.086610253858;14380.85619143837;14419.639509012359;14613.634659133606;13636.93181534086;13856.30718464093;13874.445022199;14008.43966241339;14570.562883113524;13743.518976835763;13861.37623806911;14049.859501405264;14199.858001419854;14200.360983755549;11117.388543629855;11193.328400296008;11197.496112674786;11314.773704525698;11668.416579171177;11648.708782280512;11694.356810375171;11795.882041179479;11815.232009919328;11921.642350729491 20:16:04 INFO - PROCESS | 25114 | __end_tp_report 20:16:04 INFO - PROCESS | 25114 | __start_cc_report 20:16:04 INFO - PROCESS | 25114 | _x_x_mozilla_cycle_collect,998 20:16:04 INFO - PROCESS | 25114 | __end_cc_report 20:16:04 INFO - PROCESS | 25114 | __startTimestamp1465614964054__endTimestamp 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | ------- Summary: start ------- 20:16:04 INFO - PROCESS | 25114 | Number of tests: 6 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | [#0] dojo.html Cycles:165 Average:5300.92 Median:5471.97 stddev:595.88 (10.9%) stddev-sans-first:571.35 20:16:04 INFO - PROCESS | 25114 | Values: 3066.9 3078.1 3100.1 3122.5 3130.9 5183.4 5269.4 5271.2 5371.7 5390.7 5256.0 5349.7 5375.1 5403.9 5504.4 4743.1 4807.4 4822.4 4839.7 4889.3 4912.7 4980.2 4985.1 4991.9 5029.4 4712.0 4745.7 4746.5 4940.8 4961.2 4818.9 4819.9 4819.9 4820.4 4820.9 4779.6 4796.6 4800.3 4856.9 4942.8 5371.7 5376.2 5396.5 5423.5 5432.8 5761.8 5764.0 5804.4 5807.5 5812.4 5489.1 5541.8 5544.2 5569.8 5640.7 5212.6 5242.9 5244.8 5280.8 5316.2 5733.5 5760.8 5783.3 5784.1 5785.4 5534.7 5569.7 5584.2 5588.1 5589.6 5465.9 5678.5 5716.7 5719.7 5772.4 5699.8 5708.5 5714.7 5718.0 5720.8 5417.9 5729.9 5731.8 5736.7 5737.3 4216.2 4352.3 4376.6 4408.1 4430.7 3929.3 3937.0 3939.1 3951.1 3973.5 5314.1 5380.9 5432.1 5439.9 5441.1 5762.7 5804.5 5839.3 5840.7 5883.3 5440.1 5468.2 5470.9 5472.0 5472.1 4912.7 4961.0 4993.5 5017.3 5073.2 5965.1 5970.6 5973.1 5976.1 6018.3 5804.2 5806.6 5818.5 5819.4 5822.5 5763.6 5772.7 5807.6 5845.6 5961.4 5652.5 5654.8 5662.9 5663.1 5664.9 5656.4 5663.8 5695.8 5712.4 5713.6 5470.4 5497.6 5518.0 5550.0 5577.3 5492.9 5497.9 5512.8 5546.4 5562.7 5328.4 5433.8 5439.5 5448.0 5487.1 5390.4 5535.6 5572.6 5604.1 5609.6 5434.2 5457.4 5534.8 5538.3 5539.8 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | [#1] ext.html Cycles:180 Average:59807.98 Median:22318.07 stddev:117611.37 (527.0%) stddev-sans-first:117857.29 20:16:04 INFO - PROCESS | 25114 | Values: 601.1 617.8 629.4 638.6 642.9 30606.4 31194.7 43314.8 43660.8 43801.3 40281.0 44756.0 44764.0 44919.0 44929.8 8781.0 8909.9 8925.7 8931.0 8931.1 8658.5 8757.1 8764.4 8764.7 8764.9 8760.3 8810.8 8814.6 8815.4 8817.0 8723.0 8789.0 8790.0 8790.4 8792.3 8684.7 8776.3 8791.0 8793.5 8795.6 41464.0 41615.2 41834.0 41892.8 41905.6 3557.5 3617.8 3651.0 3683.9 3684.2 32050.7 32637.2 32754.7 32773.2 33051.5 3966.4 4015.8 4033.3 4071.8 4143.2 361043.0 365137.0 365540.0 367352.2 367594.0 58616.0 61182.0 62186.7 62194.0 62212.7 62880.7 64339.7 64443.0 69841.0 69901.0 15966.7 16018.0 16070.6 16140.5 16142.4 11206.2 11374.3 11410.7 11480.9 11493.4 17836.0 19195.5 19558.5 19582.8 19587.1 6951.3 6982.5 7001.3 7046.6 7263.4 1009.8 1019.7 1051.6 1117.1 1135.6 32770.7 32791.7 32797.5 33091.0 33204.7 1106.6 1132.3 1146.8 1156.6 1177.9 16266.3 16916.2 17234.4 17404.4 17457.8 550399.0 551541.0 552572.0 553252.0 554193.0 57052.7 57826.7 57884.1 57976.0 57987.0 1266.5 1358.1 1368.8 1394.3 1396.1 32102.8 33637.7 34001.8 34093.5 34490.5 50010.2 50533.5 50540.7 50626.0 50664.7 387555.0 388448.0 388862.0 389343.0 390004.0 23744.9 27901.0 27936.6 28825.7 29110.7 47775.5 48417.3 48437.8 48561.3 49845.0 40564.4 41368.6 41488.6 41696.8 42471.4 39512.0 40476.4 40843.8 41068.4 41376.8 39628.4 40551.4 41152.4 41161.4 41205.0 34642.8 35695.0 36128.0 37030.3 37096.0 25202.9 25444.6 25565.5 25803.7 25871.0 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | [#2] jquery.html Cycles:180 Average:30084.11 Median:3620.74 stddev:81181.95 (2242.1%) stddev-sans-first:81379.08 20:16:04 INFO - PROCESS | 25114 | Values: 395.4 400.9 401.0 401.3 423.2 13752.4 16346.3 17575.5 18985.2 18986.1 14547.6 15098.8 17334.7 17675.4 17690.6 5418.6 5424.0 5648.1 5689.4 5737.8 5709.9 5716.9 5733.6 5759.4 5765.5 3779.5 6859.2 7199.4 7201.5 7205.1 7071.2 7089.9 7129.7 7279.8 7290.3 6814.0 6848.7 7008.5 7011.8 7061.1 25108.9 25466.2 25638.4 25696.4 25702.1 2540.0 2588.5 2670.3 2886.6 2896.0 15032.5 15064.4 15096.8 15326.5 16025.2 1994.9 2041.2 2078.4 2103.1 2155.9 69479.7 72143.0 72548.3 91868.0 95497.0 16871.2 17365.5 17399.4 17584.8 17837.5 30842.0 30956.2 31285.5 31409.2 31421.5 8713.9 8786.2 9239.9 9348.3 10186.7 8187.0 8213.5 8249.8 8352.7 8389.4 8703.4 8756.2 8869.5 8983.0 9001.8 3477.2 3515.2 3516.8 3554.7 3686.8 903.4 968.1 992.2 1016.7 1016.9 17269.4 17767.8 17943.8 18871.2 18966.5 973.3 975.3 984.8 993.9 1051.4 10026.4 10186.9 10567.5 10717.9 10985.0 481355.0 492294.0 494455.0 495293.0 498943.0 91803.5 97144.0 99059.5 99178.5 99212.5 1002.9 1021.4 1031.7 1043.8 1046.7 16263.7 16663.0 16990.9 17022.2 17093.5 40117.4 40228.4 40589.8 41483.2 41784.0 57212.0 59006.4 59712.7 60030.7 60728.7 8266.5 8338.8 8468.0 8571.3 8692.4 9468.7 12587.6 12780.3 12844.3 13497.8 7812.1 11100.7 11317.0 11420.3 11645.8 11015.6 11146.7 11158.1 11170.0 11218.2 11486.9 11567.5 11696.2 11757.1 12021.8 8443.8 8491.4 8557.4 8629.3 8716.0 11068.7 11494.4 11516.5 11679.0 11682.4 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | [#3] mootools.html Cycles:180 Average:6039.90 Median:457.48 stddev:3513.43 (768.0%) stddev-sans-first:3505.24 20:16:04 INFO - PROCESS | 25114 | Values: 1302.1 1372.1 1419.1 1507.7 1765.9 8718.3 9114.5 9141.3 9358.4 9400.3 9028.4 9259.3 9259.6 9277.0 9290.1 2356.9 2379.7 2380.7 2381.9 2382.4 2437.6 2438.6 2482.3 2490.4 2491.1 2422.2 2432.5 2455.5 2456.6 2466.9 2329.2 2332.0 2336.7 2340.4 2388.8 2284.0 2353.6 2359.8 2364.5 2366.7 7813.3 8000.2 9209.5 9292.6 9303.3 5248.2 5433.7 5434.4 5480.4 5496.2 3398.1 3498.4 3527.1 3528.9 3538.1 1155.8 1171.9 1186.6 1186.7 1189.9 12936.0 13032.5 13057.1 13065.5 13073.5 4757.3 4809.6 4855.4 4855.8 4961.4 10885.5 10911.6 10934.3 10945.5 10945.8 5475.5 5477.0 5482.2 5483.4 5486.7 4937.3 4990.1 5064.6 5151.7 5159.7 3776.2 3804.4 3876.1 3881.0 3908.3 1266.9 1276.9 1288.9 1301.3 1304.3 848.6 956.3 1000.8 1009.2 1027.5 6244.2 6343.6 6345.8 6354.4 6417.0 449.4 456.2 458.8 464.5 470.1 4085.2 4159.9 4164.6 4213.4 4224.5 11098.4 11484.8 11566.3 11579.2 11591.8 11386.0 11474.6 11532.2 11532.5 11540.5 8269.3 8557.0 8589.4 8621.2 8673.1 6280.4 6477.4 6516.3 6618.9 6637.0 10471.0 10720.5 10747.7 10916.8 10937.7 10546.7 10767.1 10951.1 10969.3 10970.2 7609.2 7876.4 7887.2 8052.6 8096.0 8713.8 8899.2 9039.9 9050.5 9051.6 7952.7 8009.1 8166.9 8185.5 8264.8 7798.5 7846.9 7862.2 7937.0 7957.6 7059.1 7135.5 7203.5 7253.3 7344.1 4296.8 5384.1 5420.3 5453.7 5653.0 5417.2 5430.1 5453.4 5466.3 5598.0 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | [#4] prototype.html Cycles:180 Average:4651.82 Median:5258.09 stddev:1353.04 (25.7%) stddev-sans-first:1317.18 20:16:04 INFO - PROCESS | 25114 | Values: 319.7 321.4 327.3 328.4 331.9 5336.0 5339.2 5342.9 5355.6 5370.4 5249.5 5259.9 5273.6 5280.7 5281.7 3951.5 4117.8 4175.3 4220.5 4222.2 4134.8 4184.9 4188.0 4194.9 4219.5 4158.9 4163.7 4176.6 4178.9 4181.4 4027.3 4042.4 4174.8 4176.9 4210.2 3655.6 3689.6 3692.1 3697.0 3722.5 5133.9 5137.7 5191.4 5205.4 5256.3 4528.3 4644.2 4776.0 4794.2 4838.5 5477.4 5540.4 5549.2 5560.6 5645.3 4069.2 4080.9 4116.1 4116.4 4130.5 5633.4 5733.7 5736.0 5759.6 5814.7 4093.0 4138.2 4166.8 4185.6 4206.3 4231.1 4242.3 4246.4 4251.4 4253.7 4617.8 4745.2 4748.2 4809.4 4846.8 5529.3 5551.5 5558.7 5565.8 5577.4 1436.0 1439.4 1452.0 1454.9 1469.1 924.2 934.0 940.7 946.9 949.8 4744.5 4768.6 4781.4 4788.0 4819.1 5106.7 5135.3 5163.4 5167.7 5198.8 4722.8 4888.7 4923.4 5029.7 5428.7 2915.3 2953.7 3029.2 3052.8 3070.2 5864.6 5874.9 5890.2 5892.9 5914.6 5581.5 5849.4 5874.6 5878.8 5882.2 5839.4 5880.8 5906.2 5924.5 5955.4 5533.4 5696.5 5721.0 5750.3 5752.0 5585.5 5604.8 5677.4 5690.6 5733.4 5829.2 5842.6 5882.6 5886.2 5922.9 3880.7 3956.0 4025.6 4036.8 4046.2 5542.3 5544.0 5661.5 5667.5 5679.2 5545.8 5552.4 5614.2 5634.2 5649.3 5313.3 5404.5 5466.8 5497.5 5566.0 5427.8 5453.9 5464.3 5481.2 5491.7 5526.5 5531.5 5543.6 5558.2 5558.5 5169.3 5428.6 5442.2 5442.3 5461.0 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - PROCESS | 25114 | [#5] yui.html Cycles:180 Average:20896.25 Median:3942.50 stddev:30047.50 (762.1%) stddev-sans-first:30093.57 20:16:04 INFO - PROCESS | 25114 | Values: 711.7 729.8 751.0 779.0 825.4 15007.0 15848.9 15889.7 15904.3 15929.3 13567.8 13577.9 13646.9 13921.2 14127.2 669.6 820.4 825.6 826.0 826.5 785.7 804.5 807.8 810.6 813.8 850.4 852.2 855.8 856.6 857.1 707.2 831.6 850.4 850.4 850.8 619.5 619.9 623.6 627.0 627.3 13658.9 13792.4 13794.2 13990.2 13991.4 14595.5 15448.3 15553.1 15596.6 15797.1 12072.7 12388.5 12404.3 12467.6 12593.5 3889.3 3931.6 3953.3 4004.3 4107.8 78674.0 79688.6 79949.0 80417.6 80950.0 11899.2 12095.5 12152.8 12177.6 12306.1 23211.0 23236.5 23238.3 23252.8 23286.1 8054.6 8301.1 8396.7 8424.7 8656.1 4265.4 4323.0 4417.2 4514.0 4567.3 3353.3 3497.8 3503.4 3505.9 3510.9 598.8 614.1 647.3 654.3 688.9 731.2 749.3 765.1 779.3 785.4 9571.1 10018.4 10020.2 10062.2 10083.5 636.3 667.8 696.3 725.1 742.6 4559.1 4571.1 4620.6 4679.6 4701.4 120708.4 121824.0 123661.0 123725.4 124659.4 81904.6 89718.6 89768.0 90655.0 107155.5 80899.2 83069.0 83462.0 83957.0 84171.2 10232.4 10302.9 10405.4 10671.8 10724.1 47819.0 49541.5 50747.7 50769.7 52023.0 65967.3 74046.6 74337.3 74534.6 74572.6 12842.5 12913.7 13040.3 13121.1 13532.1 14945.5 15500.6 15855.4 15884.9 15910.9 9732.7 13314.1 14380.9 14419.6 14613.6 13636.9 13856.3 13874.4 14008.4 14570.6 13743.5 13861.4 14049.9 14199.9 14200.4 11117.4 11193.3 11197.5 11314.8 11668.4 11648.7 11694.4 11795.9 11815.2 11921.6 20:16:04 INFO - PROCESS | 25114 | -------- Summary: end -------- 20:16:04 INFO - PROCESS | 25114 | 20:16:04 INFO - TEST-INFO | 25114: exit 0 20:16:04 INFO - TEST-OK | dromaeo_css | took 1114189ms 20:16:04 INFO - TEST-START | kraken 20:16:04 INFO - operating with platform_type : linux_ 20:16:04 INFO - Initialising browser for kraken test... 20:16:04 INFO - TEST-INFO | started process 25291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKdl7Bb/profile http://localhost:45121/getInfo.html) 20:16:09 INFO - PROCESS | 25291 | __metrics Screen width/height:1600/1200 20:16:09 INFO - PROCESS | 25291 | colorDepth:24 20:16:09 INFO - PROCESS | 25291 | Browser inner width/height: 1024/697 20:16:09 INFO - PROCESS | 25291 | __metrics 20:16:10 INFO - PROCESS | 25291 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:16:10 INFO - PROCESS | 25291 | console.error: PushService: 20:16:10 INFO - PROCESS | 25291 | stateChangeProcessEnqueue: Error transitioning state 20:16:10 INFO - PROCESS | 25291 | UnknownError 20:16:11 INFO - TEST-INFO | 25291: exit 0 20:16:11 INFO - Browser initialized. 20:16:11 INFO - Running cycle 1/1 for kraken test... 20:16:11 INFO - TEST-INFO | started process 25374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKdl7Bb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:23 INFO - PROCESS | 25374 | RSS: Main: 174039040 20:16:23 INFO - PROCESS | 25374 | 20:16:25 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45121/tests/kraken/driver.html?testName=audio-beat-detection) 20:16:26 INFO - PROCESS | 25374 | RSS: Main: 233111552 20:16:26 INFO - PROCESS | 25374 | 20:16:29 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45121/tests/kraken/driver.html?testName=audio-dft) 20:16:29 INFO - PROCESS | 25374 | RSS: Main: 220033024 20:16:29 INFO - PROCESS | 25374 | 20:16:33 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45121/tests/kraken/driver.html?testName=audio-fft) 20:16:33 INFO - PROCESS | 25374 | RSS: Main: 286658560 20:16:33 INFO - PROCESS | 25374 | 20:16:35 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45121/tests/kraken/driver.html?testName=audio-oscillator) 20:16:36 INFO - PROCESS | 25374 | RSS: Main: 198230016 20:16:36 INFO - PROCESS | 25374 | 20:16:38 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:16:39 INFO - PROCESS | 25374 | RSS: Main: 201125888 20:16:39 INFO - PROCESS | 25374 | 20:16:42 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45121/tests/kraken/driver.html?testName=imaging-darkroom) 20:16:42 INFO - PROCESS | 25374 | RSS: Main: 236093440 20:16:42 INFO - PROCESS | 25374 | 20:16:46 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45121/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:46 INFO - PROCESS | 25374 | RSS: Main: 237293568 20:16:46 INFO - PROCESS | 25374 | 20:16:49 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45121/tests/kraken/driver.html?testName=json-parse-financial) 20:16:50 INFO - PROCESS | 25374 | RSS: Main: 238288896 20:16:50 INFO - PROCESS | 25374 | 20:16:51 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:16:52 INFO - PROCESS | 25374 | RSS: Main: 225386496 20:16:52 INFO - PROCESS | 25374 | 20:16:53 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:16:54 INFO - PROCESS | 25374 | RSS: Main: 229109760 20:16:54 INFO - PROCESS | 25374 | 20:16:56 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:57 INFO - PROCESS | 25374 | RSS: Main: 237211648 20:16:57 INFO - PROCESS | 25374 | 20:16:59 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:17:00 INFO - PROCESS | 25374 | RSS: Main: 240009216 20:17:00 INFO - PROCESS | 25374 | 20:17:03 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:17:03 INFO - PROCESS | 25374 | RSS: Main: 239230976 20:17:03 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | Cycle 1(1): loaded http://localhost:45121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45121/tests/kraken/driver.html?testName=ai-astar) 20:17:05 INFO - PROCESS | 25374 | RSS: Main: 282914816 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | __start_tp_report 20:17:05 INFO - PROCESS | 25374 | _x_x_mozilla_page_load 20:17:05 INFO - PROCESS | 25374 | _x_x_mozilla_page_load_details 20:17:05 INFO - PROCESS | 25374 | |i|pagename|runs| 20:17:05 INFO - PROCESS | 25374 | |0;ai-astar;110;105;109;110;109;110;109;109;112;108 20:17:05 INFO - PROCESS | 25374 | |1;audio-beat-detection;147;129;128;201;127;126;153;125;165;125 20:17:05 INFO - PROCESS | 25374 | |2;audio-dft;162;160;162;160;160;164;161;164;162;162 20:17:05 INFO - PROCESS | 25374 | |3;audio-fft;74;74;75;121;86;76;75;74;104;75 20:17:05 INFO - PROCESS | 25374 | |4;audio-oscillator;84;85;116;86;86;85;117;86;85;127 20:17:05 INFO - PROCESS | 25374 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;116;117 20:17:05 INFO - PROCESS | 25374 | |6;imaging-darkroom;147;146;147;146;146;145;146;146;147;147 20:17:05 INFO - PROCESS | 25374 | |7;imaging-desaturate;94;95;95;95;95;95;94;94;95;95 20:17:05 INFO - PROCESS | 25374 | |8;json-parse-financial;52;54;54;54;54;54;54;54;53;53 20:17:05 INFO - PROCESS | 25374 | |9;json-stringify-tinderbox;60;61;61;60;61;61;62;61;66;61 20:17:05 INFO - PROCESS | 25374 | |10;stanford-crypto-aes;78;84;81;78;91;81;80;80;114;78 20:17:05 INFO - PROCESS | 25374 | |11;stanford-crypto-ccm;135;127;127;127;119;147;119;127;130;126 20:17:05 INFO - PROCESS | 25374 | |12;stanford-crypto-pbkdf2;162;158;164;157;163;158;155;160;164;160 20:17:05 INFO - PROCESS | 25374 | |13;stanford-crypto-sha256-iterative;63;64;62;63;62;65;63;62;63;61 20:17:05 INFO - PROCESS | 25374 | __end_tp_report 20:17:05 INFO - PROCESS | 25374 | __start_cc_report 20:17:05 INFO - PROCESS | 25374 | _x_x_mozilla_cycle_collect,1633 20:17:05 INFO - PROCESS | 25374 | __end_cc_report 20:17:05 INFO - PROCESS | 25374 | __startTimestamp1465615025734__endTimestamp 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | ------- Summary: start ------- 20:17:05 INFO - PROCESS | 25374 | Number of tests: 14 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:1.79 (1.6%) stddev-sans-first:1.87 20:17:05 INFO - PROCESS | 25374 | Values: 110.0 105.0 109.0 110.0 109.0 110.0 109.0 109.0 112.0 108.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:138.00 stddev:24.89 (18.0%) stddev-sans-first:26.35 20:17:05 INFO - PROCESS | 25374 | Values: 147.0 129.0 128.0 201.0 127.0 126.0 153.0 125.0 165.0 125.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 20:17:05 INFO - PROCESS | 25374 | Values: 162.0 160.0 162.0 160.0 160.0 164.0 161.0 164.0 162.0 162.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:16.25 (21.7%) stddev-sans-first:16.88 20:17:05 INFO - PROCESS | 25374 | Values: 74.0 74.0 75.0 121.0 86.0 76.0 75.0 74.0 104.0 75.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:85.00 stddev:17.02 (20.0%) stddev-sans-first:17.52 20:17:05 INFO - PROCESS | 25374 | Values: 84.0 85.0 116.0 86.0 86.0 85.0 117.0 86.0 85.0 127.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:17:05 INFO - PROCESS | 25374 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 20:17:05 INFO - PROCESS | 25374 | Values: 147.0 146.0 147.0 146.0 146.0 145.0 146.0 146.0 147.0 147.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:17:05 INFO - PROCESS | 25374 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.44 20:17:05 INFO - PROCESS | 25374 | Values: 52.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 53.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.71 (2.8%) stddev-sans-first:1.74 20:17:05 INFO - PROCESS | 25374 | Values: 60.0 61.0 61.0 60.0 61.0 61.0 62.0 61.0 66.0 61.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:80.50 stddev:11.08 (13.8%) stddev-sans-first:11.50 20:17:05 INFO - PROCESS | 25374 | Values: 78.0 84.0 81.0 78.0 91.0 81.0 80.0 80.0 114.0 78.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:127.00 stddev:8.04 (6.3%) stddev-sans-first:8.17 20:17:05 INFO - PROCESS | 25374 | Values: 135.0 127.0 127.0 127.0 119.0 147.0 119.0 127.0 130.0 126.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:161.00 stddev:3.11 (1.9%) stddev-sans-first:3.22 20:17:05 INFO - PROCESS | 25374 | Values: 162.0 158.0 164.0 157.0 163.0 158.0 155.0 160.0 164.0 160.0 20:17:05 INFO - PROCESS | 25374 | 20:17:05 INFO - PROCESS | 25374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 20:17:05 INFO - PROCESS | 25374 | Values: 63.0 64.0 62.0 63.0 62.0 65.0 63.0 62.0 63.0 61.0 20:17:05 INFO - PROCESS | 25374 | -------- Summary: end -------- 20:17:05 INFO - PROCESS | 25374 | 20:17:06 INFO - TEST-INFO | 25374: exit 0 20:17:06 INFO - TEST-OK | kraken | took 61944ms 20:17:06 INFO - SUITE-END | took 1176s 20:17:06 INFO - Completed test suite (00:19:36) 20:17:06 INFO - javascript benchmark 20:17:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3066.8926587569426, 3078.091962870953, 3100.1164668069596, 3122.516010018448, 3130.89041883534, 5183.352080989876, 5269.394019687737, 5271.15661494161, 5371.731413429327, 5390.676559406438, 5256.027634887549, 5349.652272602288, 5375.086235339992, 5403.864903377417, 5504.394516603171, 4743.12252233337, 4807.375041244651, 4822.373091498101, 4839.716593172482, 4889.33993910821, 4912.656114072016, 4980.203167493201, 4985.07776061428, 4991.875203119915, 5029.3964724232965, 4711.976440117812, 4745.667803253739, 4746.52534746526, 4940.777665005084, 4961.156603377416, 4818.879528011793, 4819.855404337875, 4819.855404337875, 4820.421549414093, 4820.879478013043, 4779.617630589544, 4796.616270698336, 4800.303955926406, 4856.902861942742, 4942.827001054981, 5371.704556249405, 5376.193570964348, 5396.514313711785, 5423.484768946943, 5432.75552600134, 5761.827145185609, 5763.971180144114, 5804.419558044162, 5807.506361959238, 5812.360640329561, 5489.094299440588, 5541.750621222055, 5544.16837474378, 5569.832905012856, 5640.689762063085, 5212.556932660728, 5242.9213561796605, 5244.763985620618, 5280.788768449257, 5316.175992721134, 5733.541316694655, 5760.769569217268, 5783.277090363705, 5784.132380143013, 5785.4214578541805, 5534.695591742412, 5569.693666848362, 5584.162375643605, 5588.050031494656, 5589.636673616202, 5465.890682186334, 5678.517326027334, 5716.714164291769, 5719.714014299351, 5772.3938986406665, 5699.829005129853, 5708.457696518824, 5714.7428365723645, 5718.0, 5720.771169153188, 5417.891642167135, 5729.914051289234, 5731.799387021434, 5736.68448235351, 5737.3115226172295, 4216.219999300078, 4352.281873490839, 4376.562343765598, 4408.140412619572, 4430.734155950653, 3929.2927273090545, 3936.980315098406, 3939.1136994176654, 3951.091249012743, 3973.4834471518516, 5314.0700377433795, 5380.946190538123, 5432.076546987022, 5439.891202175934, 5441.075017247077, 5762.74067666956, 5804.506616937523, 5839.270091238595, 5840.707964601753, 5883.294004719461, 5440.102383106822, 5468.207109969112, 5470.890582188334, 5471.972640136773, 5472.069748142825, 4912.729799861042, 4961.0, 4993.525615066563, 5017.297578339036, 5073.188289873602, 5965.13505541694, 5970.582059255898, 5973.104034394789, 5976.073708575178, 6018.337982821886, 5804.245448091721, 5806.622569532967, 5818.534517238695, 5819.388964158702, 5822.475977162076, 5763.567732420001, 5772.6536407815665, 5807.622504537191, 5845.590808643354, 5961.433663802105, 5652.547796176378, 5654.773809047757, 5662.85842853932, 5663.093904975184, 5664.886702266014, 5656.43435656431, 5663.801766938137, 5695.829125126253, 5712.400197979152, 5713.628614140068, 5470.425605311544, 5497.615166938276, 5518.034343989866, 5549.972250138723, 5577.330720313588, 5492.945070549403, 5497.862553436036, 5512.751926163252, 5546.389897111395, 5562.749676264497, 5328.413874473727, 5433.782648694008, 5439.537639300545, 5448.046591846491, 5487.122060470306, 5390.407055224001, 5535.640183388067, 5572.582056345709, 5604.075327570905, 5609.5512359012, 5434.157705555645, 5457.372402173801, 5534.750936207961, 5538.307711536058, 5539.7784088636], "value": 5261.221605488074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.0953514959984, 617.7961272779983, 629.442942995449, 638.639168869589, 642.8553575445524, 30606.38787224257, 31194.688053119462, 43314.783426082824, 43660.78169609147, 43801.342979855326, 40281.0, 44756.0, 44764.0, 44919.0, 44929.7753511232, 8780.956095219532, 8909.866352004725, 8925.687600933968, 8931.0, 8931.106889311082, 8658.48049117055, 8757.124287571256, 8764.43031202973, 8764.737057888242, 8764.868526972068, 8760.342974276955, 8810.823783524358, 8814.603342849556, 8815.382923195379, 8817.0, 8722.956385218065, 8789.0, 8789.956050219773, 8790.384673072887, 8792.34057445691, 8684.652613895436, 8776.341774366949, 8791.032986371494, 8793.516356600385, 8795.604197811113, 41464.0, 41615.167696646204, 41834.0, 41892.79053604743, 41905.58094419047, 3557.484164796116, 3617.782933024027, 3650.995976106565, 3683.907902302437, 3684.171061511165, 32050.679493205236, 32637.184070398194, 32754.6724532754, 32773.18067048319, 33051.504227436366, 3966.3852102923806, 4015.7791321477307, 4033.2740106780766, 4071.75569465833, 4143.212789570002, 361043.0, 365137.0, 365540.0, 367352.16323918477, 367594.0, 58616.0, 61182.0, 62186.689066555286, 62194.0, 62212.68893655503, 62880.685596571726, 64339.67830160819, 64443.0, 69841.0, 69901.0, 15966.680666386606, 16018.0, 16070.598235044217, 16140.515784526482, 16142.435014774426, 11206.215564910379, 11374.31754094757, 11410.657680269605, 11480.885191148149, 11493.367864767351, 17836.019018953823, 19195.520111997314, 19558.5110372239, 19582.804171958098, 19587.11857966395, 6951.304869513109, 6982.47631427645, 7001.264867188974, 7046.6476676165985, 7263.3826124778925, 1009.7627057641448, 1019.7093828258911, 1051.6476980211714, 1117.1118960426481, 1135.625243669587, 32770.67229327724, 32791.67208327886, 32797.508037379455, 33091.0, 33204.68711044627, 1106.5684383090602, 1132.3432409202642, 1146.7534480086822, 1156.5720683347215, 1177.8645455772696, 16266.349346026263, 16916.238769255415, 17234.396796112076, 17404.39084632032, 17457.825421745874, 550399.0, 551541.0, 552572.0, 553252.0, 554193.0, 57052.71473642688, 57826.7108664454, 57884.13173802396, 57976.0, 57987.0, 1266.4554241676167, 1358.076507974567, 1368.8152099466445, 1394.2540740703676, 1396.057661078788, 32102.839485802422, 33637.66362336443, 34001.82999084989, 34093.488597670555, 34490.48264276088, 50010.249846253064, 50533.49466505288, 50540.74729626328, 50626.0, 50664.74667626786, 387555.0, 388448.0, 388862.0, 389343.0, 390004.0, 23744.88127559351, 27901.0, 27936.580951286152, 28825.711742882304, 29110.708892911647, 47775.5222447785, 48417.27374089321, 48437.757811210715, 48561.27158092702, 49845.0, 40564.3915341276, 41368.586314136475, 41488.58511414968, 41696.79151604223, 42471.362929555464, 39512.0, 40476.3928541078, 40843.795781020905, 41068.383974241005, 41376.79311603423, 39628.405573915836, 40551.391729124676, 41152.38271425871, 41161.38257926193, 41205.0, 34642.82678586591, 35695.0, 36128.0, 37030.25939481249, 37096.0, 25202.873985629954, 25444.618330724683, 25565.488690226462, 25803.741962580134, 25871.0], "value": 19999.469970961436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.3575439910146, 400.87572852415735, 400.98396064157436, 401.3117503481529, 423.23394655673235, 13752.381142848571, 16346.34614615414, 17575.472735817915, 18985.240590376387, 18986.05069746512, 14547.636309092279, 15098.849011509908, 17334.739978900325, 17675.381361652344, 17690.557736056606, 5418.564080518656, 5423.996560636275, 5648.124540696178, 5689.402612725667, 5737.827865164031, 5709.914351284734, 5716.942830571704, 5733.627314224562, 5759.424057594249, 5765.509931655814, 3779.4708740776314, 6859.2454829968665, 7199.424046076301, 7201.459890508207, 7205.063341765589, 7071.1868135164605, 7089.893651595205, 7129.714811407537, 7279.818004549876, 7290.3438690518105, 6813.965930170318, 6848.657567121624, 7008.474364422637, 7011.789646310619, 7061.1173603299585, 25108.874455627603, 25466.236012919642, 25638.359041023938, 25696.357591060187, 25702.100426484983, 2539.987300063506, 2588.4823035392997, 2670.252329347766, 2886.581445690384, 2895.971040289591, 15032.549023529311, 15064.397424103023, 15096.849031509653, 15326.540203793904, 16025.19874006295, 1994.8902810345426, 2041.2345370486069, 2078.418042947977, 2103.1061798735477, 2155.8706477611236, 69479.65260173718, 72143.0, 72548.27451725469, 91868.0, 95497.0, 16871.240794164045, 17365.479035628952, 17399.391021314193, 17584.82415175832, 17837.502749614803, 30842.0, 30956.22609434737, 31285.530717039263, 31409.214769630486, 31421.528677069862, 8713.912860871436, 8786.209241168197, 9239.90760092404, 9348.345615806827, 10186.745331366776, 8187.0, 8213.466124701876, 8249.79375515605, 8352.707655232038, 8389.370797190235, 8703.43427677199, 8756.211940925346, 8869.516535370107, 8982.955085224532, 9001.819963600823, 3477.217626034122, 3515.191505953645, 3516.7889926604485, 3554.662307080823, 3686.8156592170285, 903.421810041574, 968.080323692495, 992.161623428202, 1016.6616781402892, 1016.9186465082776, 17269.39557115495, 17767.822321776875, 17943.820561794477, 18871.245150193838, 18966.525836853914, 973.3089506450358, 975.3465178330536, 984.8128855517429, 993.8757655293089, 1051.4479898053582, 10026.448545329931, 10186.949065254626, 10567.471626418648, 10717.946410268054, 10985.0, 481355.0, 492294.0, 494455.0, 495293.0, 498943.0, 91803.54098229599, 97144.0, 99059.50470247747, 99178.50410748045, 99212.50393747985, 1002.9047240512285, 1021.371856308365, 1031.7059638003284, 1043.7912417516527, 1046.6807623674852, 16263.721029256507, 16663.0, 16990.915045424696, 17022.233999469805, 17093.487195384158, 40117.398239027025, 40228.39657405083, 40589.79705101455, 41483.1703365937, 41783.98592168959, 57212.0, 59006.40993590009, 59712.70143649254, 60030.69984650049, 60728.69635651793, 8266.462679925786, 8338.833223335378, 8467.95766021166, 8571.314294856273, 8692.391532592657, 9468.668596599086, 12587.622371328875, 12780.297083660116, 12844.293563854078, 13497.797533036815, 7812.140664527011, 11100.666979990614, 11317.0, 11420.314781112827, 11645.825312620149, 11015.614453494089, 11146.665600032013, 11158.10735141203, 11170.0, 11218.214724969173, 11486.885131148581, 11567.537298507965, 11696.239744416585, 11757.118216133995, 12021.81967270509, 8443.788905277417, 8491.363147764067, 8557.44376615518, 8629.266512346521, 8716.0, 11068.723281918017, 11494.367809770543, 11516.53933842637, 11679.0, 11682.415879206175], "value": 10103.153885477404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.1275745250682, 1372.1286982765944, 1419.063418144025, 1507.721071601753, 1765.9117044147797, 8718.258947989421, 9114.54427278636, 9141.314401419895, 9358.3917045392, 9400.294977876652, 9028.36801423899, 9259.305552083588, 9259.6296148154, 9276.953615231914, 9290.117438843316, 2356.9057237710513, 2379.690640216769, 2380.7382087493656, 2381.8928148233285, 2382.404398900275, 2437.609982402816, 2438.5976313908272, 2482.255323402972, 2490.402303447169, 2491.0533997081084, 2422.1522467136538, 2432.4648577312964, 2455.545724041049, 2456.5701002324613, 2466.851988880664, 2329.1615018593293, 2331.9650205246935, 2336.7429582745885, 2340.449994251358, 2388.79695225906, 2283.977160228393, 2353.6116540770754, 2359.8230132740114, 2364.5152743687504, 2366.7396586375485, 7813.296803287674, 8000.199980002011, 9209.493477858716, 9292.581833817494, 9303.302252331034, 5248.21276808478, 5433.701146436944, 5434.375046869621, 5480.424555421703, 5496.203050557647, 3398.082517720202, 3498.4402495600834, 3527.1358517163203, 3528.9117772055647, 3538.097785064818, 1155.78040172367, 1171.859376874772, 1186.5669030803695, 1186.7329850783592, 1189.8988585970203, 12936.0, 13032.54386096482, 13057.086003979724, 13065.477380904753, 13073.477060917647, 4757.310190022427, 4809.639277054165, 4855.417349918032, 4855.8057677693205, 4961.355023846877, 10885.510152043176, 10911.618093366695, 10934.289271197347, 10945.4527273636, 10945.83581246266, 5475.507204351547, 5477.0, 5482.205080263339, 5483.396826349099, 5486.670799751948, 4937.308776771183, 4990.101781679333, 5064.645474816801, 5151.742412879416, 5159.690418574823, 3776.244751049801, 3804.4483549885113, 3876.0503676599415, 3880.990942355008, 3908.2769687607883, 1266.9176503527242, 1276.8595454499998, 1288.890444312244, 1301.3103055380664, 1304.3347892574666, 848.6308455821737, 956.2636769687441, 1000.7898341348252, 1009.1724785675675, 1027.5067967375553, 6244.1570387997945, 6343.5876668016435, 6345.841353966188, 6354.3645635437015, 6417.038206317096, 449.35517532340543, 456.2107553931651, 458.75227377216595, 464.46354460598064, 470.1372980580604, 4085.162541678949, 4159.8960025999595, 4164.60436258561, 4213.431186789805, 4224.5353011168745, 11098.44507774608, 11484.827727584094, 11566.30602163873, 11579.247348922294, 11591.76816463666, 11386.0, 11474.598389056342, 11532.192746507664, 11532.481038353295, 11540.538378464935, 8269.255766981001, 8557.0, 8589.44168629037, 8621.180987806149, 8673.132686731276, 6280.371962803866, 6477.352264773485, 6516.348365163446, 6618.873124120104, 6637.037629543785, 10470.999999999694, 10720.463976801284, 10747.677569672922, 10916.781664366827, 10937.726556836144, 10546.736331591772, 10767.084797792275, 10951.069159121564, 10969.286996345212, 10970.232083754061, 7609.2010338913615, 7876.448648594544, 7887.1718469562165, 8052.597370131587, 8096.0, 8713.782155446164, 8899.243564297107, 9039.864402034107, 9050.456972581665, 9051.59267832936, 7952.721654742057, 8009.118996910452, 8166.918330816853, 8185.508869467851, 8264.83470330602, 7798.532088074734, 7846.882296765439, 7862.213778622092, 7937.047554293522, 7957.562334071682, 7059.082319298664, 7135.464840136907, 7203.459740519377, 7253.347198752138, 7344.118705755343, 4296.806643700978, 5384.084705599979, 5420.322459692538, 5453.672779633234, 5653.0, 5417.160340147283, 5430.099465187153, 5453.400125986218, 5466.316710411199, 5598.048331783688], "value": 4711.353130123297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.6739325887595, 321.3781333120412, 327.2603915151759, 328.4236165529495, 331.9369319829233, 5335.973320133404, 5339.199120131977, 5342.931413717262, 5355.634313250121, 5370.43610420906, 5249.451411833509, 5259.86850328742, 5273.551748101407, 5280.735963201843, 5281.656692314997, 3951.486306780115, 4117.835286588533, 4175.269327867611, 4220.451341325624, 4222.239996800575, 4134.793260336986, 4184.916301673965, 4187.979060104695, 4194.874153775391, 4219.472565929259, 4158.875233742992, 4163.729357591762, 4176.624103830654, 4178.853740119096, 4181.351890456969, 4027.2750904837117, 4042.3532234842282, 4174.833006679729, 4176.895577610554, 4210.179015092058, 3655.5796083450477, 3689.631036896316, 3692.095436618046, 3696.9630303696886, 3722.516072910504, 5133.922991155136, 5137.743112844343, 5191.3524102707515, 5205.427402985669, 5256.316678831728, 4528.298113792334, 4644.210484217658, 4775.976120119377, 4794.184988551954, 4838.467768545457, 5477.370102438231, 5540.418256083093, 5549.1676248562635, 5560.638558493725, 5645.30640807756, 4069.2065047315787, 4080.8979775505554, 4116.115035267402, 4116.403121547359, 4130.524989626201, 5633.40849210831, 5733.684647344395, 5735.971320143414, 5759.5968282220265, 5814.6511209327155, 4093.0, 4138.193052354822, 4166.791660416967, 4185.58144185579, 4206.26390381682, 4231.074860938265, 4242.342436922282, 4246.426732391149, 4251.404803327537, 4253.680973926906, 4617.769111544477, 4745.193317136095, 4748.169070412733, 4809.422869255712, 4846.830360937421, 5529.3000949192865, 5551.528120109755, 5558.749856256478, 5565.805196818092, 5577.414371490935, 1435.992820035914, 1439.3522914688433, 1451.981745373931, 1454.8545145485366, 1469.0965056490181, 924.191332583989, 933.9953300233591, 940.7412961435523, 946.9110522898584, 949.8432758594893, 4744.501827308152, 4768.569429171234, 4781.402324709411, 4787.994521150597, 4819.132556139858, 5106.7446627669215, 5135.2553879687985, 5163.40620828602, 5167.715775632301, 5198.81804136861, 4722.763861806896, 4888.706677599355, 4923.409190897115, 5029.698218106925, 5428.728563571805, 2915.344047589318, 2953.74893134086, 3029.242689327668, 3052.832094234838, 3070.1710538154575, 5864.592497800582, 5874.853128671817, 5890.175375447441, 5892.852678683067, 5914.556408269397, 5581.49766521015, 5849.415058494116, 5874.559408044413, 5878.764849406061, 5882.23530940975, 5839.357670656224, 5880.764769409347, 5906.173135760911, 5924.496417804448, 5955.434233747787, 5533.418991005887, 5696.487316141567, 5720.971395142998, 5750.281214848144, 5751.971240143773, 5585.497305242548, 5604.8318550443555, 5677.432256774455, 5690.630109042899, 5733.369329373682, 5829.213056237354, 5842.649441033552, 5882.647041177543, 5886.23478947734, 5922.911156332572, 3880.7387599030994, 3955.960440395559, 4025.6175663311938, 4036.7577945323374, 4046.2109888572622, 5542.307211598551, 5543.972280138735, 5661.490465858093, 5667.4615911488345, 5679.204911312337, 5545.833624991256, 5552.444755524415, 5614.157876318585, 5634.211210430461, 5649.293838270216, 5313.282706834528, 5404.510414079656, 5466.753996070107, 5497.51567076879, 5566.0, 5427.755750991294, 5453.864028183731, 5464.316960379952, 5481.205225242397, 5491.697956612425, 5526.530244929226, 5531.502164805187, 5543.584231182596, 5558.221848941071, 5558.49920521465, 5169.327987361619, 5428.647137936022, 5442.156465747816, 5442.319710036246, 5461.017016936989], "value": 4219.932972859322, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.7366574367485, 729.8394353242288, 751.0229963637804, 778.9717572803901, 825.352098602597, 15007.0, 15848.920755396235, 15889.682206355867, 15904.284307206175, 15929.283182256797, 13567.796483052738, 13577.932110339434, 13646.863531364683, 13921.1647301162, 14127.223002734845, 669.6283562622767, 820.3642177312586, 825.558326295432, 826.017039722728, 826.5082276045773, 785.681798871458, 804.5414113955048, 807.7980504873782, 810.6028046257321, 813.8209593889335, 850.421713235, 852.2457625001856, 855.7689423855555, 856.6402111113347, 857.0572370392581, 707.1726080485844, 831.5925196653596, 850.3834719828106, 850.3877208409934, 850.8340873529634, 619.4765423217419, 619.8667286533417, 623.6445226221056, 627.0187157099125, 627.3130921640796, 13658.863411365859, 13792.448302067905, 13794.172349658953, 13990.230537320444, 13991.370388332549, 14595.489157879529, 15448.304826282843, 15553.066815991077, 15596.61008474786, 15797.131157786318, 12072.698182545506, 12388.504459821595, 12404.317762523058, 12467.563635272722, 12593.488781346205, 3889.2999260133447, 3931.646151846319, 3953.347697629916, 4004.3392840181336, 4107.835686572534, 78674.0, 79688.60155699242, 79949.0, 80417.59791201007, 80950.0, 11899.226550274205, 12095.516179352904, 12152.756944861054, 12177.573784917662, 12306.07704422172, 23211.0, 23236.53526929452, 23238.3028509145, 23252.7674723254, 23286.06855725752, 8054.59727013647, 8301.086880443147, 8396.706115285935, 8424.663013479392, 8656.09111043344, 4265.360195970629, 4323.0, 4417.182821178092, 4513.977430112828, 4567.314902764612, 3353.2622822978906, 3497.842597083137, 3503.4219353806848, 3505.8948231553095, 3510.929781404409, 598.7664810723821, 614.121805817685, 647.3106141958799, 654.3293124547282, 688.9242183359827, 731.2029887422734, 749.3443237167478, 765.1010063175746, 779.3180966654178, 785.4384115357547, 9571.09802480669, 10018.448985305733, 10020.198384129251, 10062.19270292176, 10083.49582520871, 636.287358158865, 667.846395329077, 696.2967402923084, 725.1189804387694, 742.6296246588756, 4559.133764584718, 4571.085782843445, 4620.584147426748, 4679.64902632304, 4701.365315682339, 120708.39645801715, 121824.0, 123661.0, 123725.38137309256, 124659.37670311591, 81904.59047704842, 89718.55140724254, 89768.0, 90655.0, 107155.46422267839, 80899.19100809035, 83069.0, 83461.99228046337, 83957.0, 84171.15828841634, 10232.386056836614, 10302.948485257526, 10405.427701476188, 10671.786564268827, 10724.088452481314, 47819.0, 49541.50458495513, 50747.746261268454, 50769.74615127048, 52023.0, 65967.34032659612, 74046.62976685082, 74337.2566274352, 74534.62732686302, 74572.62713686397, 12842.486300547873, 12913.741725165257, 13040.282784446947, 13121.081524293208, 13532.052756306965, 14945.476908308157, 15500.612484687974, 15855.445059422866, 15884.92057539705, 15910.920445397698, 9732.70801875945, 13314.086610253858, 14380.85619143837, 14419.639509012359, 14613.634659133606, 13636.93181534086, 13856.30718464093, 13874.445022199, 14008.43966241339, 14570.562883113524, 13743.518976835763, 13861.37623806911, 14049.859501405264, 14199.858001419854, 14200.360983755549, 11117.388543629855, 11193.328400296008, 11197.496112674786, 11314.773704525698, 11668.416579171177, 11648.708782280512, 11694.356810375171, 11795.882041179479, 11815.232009919328, 11921.642350729491], "value": 7617.11961988399, "unit": "score"}], "name": "dromaeo_css", "value": 7375.786703566158, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 112.0, 108.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 129.0, 128.0, 201.0, 127.0, 126.0, 153.0, 125.0, 165.0, 125.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 160.0, 160.0, 164.0, 161.0, 164.0, 162.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 121.0, 86.0, 76.0, 75.0, 74.0, 104.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 116.0, 86.0, 86.0, 85.0, 117.0, 86.0, 85.0, 127.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 61.0, 66.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 81.0, 78.0, 91.0, 81.0, 80.0, 80.0, 114.0, 78.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 127.0, 127.0, 127.0, 119.0, 147.0, 119.0, 127.0, 130.0, 126.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 164.0, 157.0, 163.0, 158.0, 155.0, 160.0, 164.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 62.0, 65.0, 63.0, 62.0, 63.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1501.1, "alertThreshold": 2.0}]} 20:17:06 INFO - Return code: 0 20:17:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:17:07 INFO - # TBPL SUCCESS # 20:17:07 INFO - Running post-action listener: _resource_record_post_action 20:17:07 INFO - ##### 20:17:07 INFO - ##### Finished run-tests step (success) 20:17:07 INFO - ##### 20:17:07 INFO - Running post-run listener: _resource_record_post_run 20:17:07 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541483008; Read time: 8; Write time: 367352 20:17:07 INFO - TinderboxPrint: CPU usage
13.2% 20:17:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:17:07 INFO - TinderboxPrint: I/O write bytes / time
541,483,008 / 367,352 20:17:07 INFO - TinderboxPrint: CPU idle
8,273.4 (86.8%) 20:17:07 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 20:17:07 INFO - TinderboxPrint: Swap in / out
0 / 0 20:17:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 138502144; Read time: 0; Write time: 122520 20:17:07 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292536320; Read time: 8; Write time: 163052 20:17:07 INFO - Running post-run listener: _upload_blobber_files 20:17:07 INFO - Blob upload gear active. 20:17:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:17:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:17:08 INFO - (blobuploader) - INFO - Open directory for files ... 20:17:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:17:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:17:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:09 INFO - (blobuploader) - INFO - Done attempting. 20:17:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:17:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:13 INFO - (blobuploader) - INFO - Done attempting. 20:17:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:17:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:13 INFO - (blobuploader) - INFO - Done attempting. 20:17:13 INFO - (blobuploader) - INFO - Iteration through files over. 20:17:13 INFO - Return code: 0 20:17:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:17:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:17:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c2e776f0350c89e47bc27ca2ae457d78380418d6facb0b2ee2da6055b3f9e550420111e34858fbf328ec0648045ba10d0425c8b7317994fc74276ad7fe28c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09039db160e0e0d28b9363adf02adc31c2743f56e12fa3287768aaa52804919c96741a309b041c47ef61ebdc7ad0910540dbc04f67039f59058d9ed0c3e8fb92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e41029a998198cf3942af834ad8b1c610e47f028055880735c9762709202279f6a9aaf400a97100019e0f26ef8e272f09e1f2fc6af082dd09d8c84a77813dc9"} 20:17:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:17:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:17:13 INFO - Contents: 20:17:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c2e776f0350c89e47bc27ca2ae457d78380418d6facb0b2ee2da6055b3f9e550420111e34858fbf328ec0648045ba10d0425c8b7317994fc74276ad7fe28c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09039db160e0e0d28b9363adf02adc31c2743f56e12fa3287768aaa52804919c96741a309b041c47ef61ebdc7ad0910540dbc04f67039f59058d9ed0c3e8fb92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e41029a998198cf3942af834ad8b1c610e47f028055880735c9762709202279f6a9aaf400a97100019e0f26ef8e272f09e1f2fc6af082dd09d8c84a77813dc9"} 20:17:13 INFO - Running post-run listener: copy_logs_to_upload_dir 20:17:13 INFO - Copying logs to upload dir... 20:17:13 INFO - mkdir: /builds/slave/test/build/upload/logs 20:17:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.994657 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-10 20:17:13.161127) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 20:17:13.164834) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1465612445.995203-1538470066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c2e776f0350c89e47bc27ca2ae457d78380418d6facb0b2ee2da6055b3f9e550420111e34858fbf328ec0648045ba10d0425c8b7317994fc74276ad7fe28c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09039db160e0e0d28b9363adf02adc31c2743f56e12fa3287768aaa52804919c96741a309b041c47ef61ebdc7ad0910540dbc04f67039f59058d9ed0c3e8fb92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e41029a998198cf3942af834ad8b1c610e47f028055880735c9762709202279f6a9aaf400a97100019e0f26ef8e272f09e1f2fc6af082dd09d8c84a77813dc9"} build_url:https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/A5gngW-fReqfmDa57uQrLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c2e776f0350c89e47bc27ca2ae457d78380418d6facb0b2ee2da6055b3f9e550420111e34858fbf328ec0648045ba10d0425c8b7317994fc74276ad7fe28c59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/09039db160e0e0d28b9363adf02adc31c2743f56e12fa3287768aaa52804919c96741a309b041c47ef61ebdc7ad0910540dbc04f67039f59058d9ed0c3e8fb92", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e41029a998198cf3942af834ad8b1c610e47f028055880735c9762709202279f6a9aaf400a97100019e0f26ef8e272f09e1f2fc6af082dd09d8c84a77813dc9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 20:17:13.190068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 20:17:13.190420) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1465612445.995203-1538470066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 20:17:13.273732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 20:17:13.274096) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 20:17:13.274534) ========= ========= Total master_lag: 0.21 =========