builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1466624365.62 results: success (0) buildid: 20160622100424 builduid: 6a8a9cc3a1894bcfacedef17ed39722c revision: b463de85df02512c96e9e19087522c34b08fcd08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.620602) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.621560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.622795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.701937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.702204) ========= 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=0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 12:39:25-- 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% 42.9M=0s 2016-06-22 12:39:26 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090181 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.811913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.812532) ========= 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=0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014774 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.867012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:25.867920) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b463de85df02512c96e9e19087522c34b08fcd08 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b463de85df02512c96e9e19087522c34b08fcd08 --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=0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 12:39:26,211 truncating revision to first 12 chars 2016-06-22 12:39:26,211 Setting DEBUG logging. 2016-06-22 12:39:26,211 attempt 1/10 2016-06-22 12:39:26,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b463de85df02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 12:39:26,523 unpacking tar archive at: mozilla-aurora-b463de85df02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.544318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.544649) ========= script_repo_revision: b463de85df02512c96e9e19087522c34b08fcd08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.545153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.545464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 12:39:26.563942) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-22 12:39:26.564757) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:26 INFO - MultiFileLogger online at 20160622 12:39:26 in /builds/slave/test 12:39:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:39:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:26 INFO - {'append_to_log': False, 12:39:26 INFO - 'base_work_dir': '/builds/slave/test', 12:39:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:39:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:26 INFO - 'branch': 'Mozilla-Aurora', 12:39:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:26 INFO - 'config_files': ('talos/linux_config.py',), 12:39:26 INFO - 'default_actions': ('clobber', 12:39:26 INFO - 'read-buildbot-config', 12:39:26 INFO - 'download-and-extract', 12:39:26 INFO - 'populate-webroot', 12:39:26 INFO - 'create-virtualenv', 12:39:26 INFO - 'install', 12:39:26 INFO - 'run-tests'), 12:39:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:26 INFO - 'download_minidump_stackwalk': True, 12:39:26 INFO - 'download_symbols': 'ondemand', 12:39:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:26 INFO - 'installer_path': 'installer.exe', 12:39:26 INFO - 'log_level': 'info', 12:39:26 INFO - 'log_name': 'talos', 12:39:26 INFO - 'log_to_console': True, 12:39:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:26 INFO - 'opt_config_files': (), 12:39:26 INFO - 'pip_index': False, 12:39:26 INFO - 'sps_profile': False, 12:39:26 INFO - 'sps_profile_interval': 0, 12:39:26 INFO - 'suite': 'dromaeojs', 12:39:26 INFO - 'system_bits': '32', 12:39:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:26 INFO - 'title': 'talos-linux64-ix-017', 12:39:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:26 INFO - 'use_talos_json': True, 12:39:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:26 INFO - 'work_dir': 'build'} 12:39:26 INFO - ##### 12:39:26 INFO - ##### Running clobber step. 12:39:26 INFO - ##### 12:39:26 INFO - Running pre-action listener: _resource_record_pre_action 12:39:26 INFO - Running main action method: clobber 12:39:26 INFO - rmtree: /builds/slave/test/build 12:39:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:27 INFO - Running post-action listener: _resource_record_post_action 12:39:27 INFO - ##### 12:39:27 INFO - ##### Finished clobber step (success) 12:39:27 INFO - ##### 12:39:27 INFO - ##### 12:39:27 INFO - ##### Running read-buildbot-config step. 12:39:27 INFO - ##### 12:39:27 INFO - Running pre-action listener: _resource_record_pre_action 12:39:27 INFO - Running main action method: read_buildbot_config 12:39:27 INFO - Using buildbot properties: 12:39:27 INFO - { 12:39:27 INFO - "project": "", 12:39:27 INFO - "product": "firefox", 12:39:27 INFO - "script_repo_revision": "production", 12:39:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:39:27 INFO - "repository": "", 12:39:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:39:27 INFO - "buildid": "20160622100424", 12:39:27 INFO - "pgo_build": "True", 12:39:27 INFO - "basedir": "/builds/slave/test", 12:39:27 INFO - "buildnumber": 309, 12:39:27 INFO - "slavename": "talos-linux64-ix-017", 12:39:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:39:27 INFO - "platform": "ubuntu64_hw", 12:39:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:39:27 INFO - "branch": "mozilla-aurora", 12:39:27 INFO - "repo_path": "releases/mozilla-aurora", 12:39:27 INFO - "revision": "b463de85df02512c96e9e19087522c34b08fcd08", 12:39:27 INFO - "stage_platform": "linux64-pgo", 12:39:27 INFO - "builduid": "6a8a9cc3a1894bcfacedef17ed39722c", 12:39:27 INFO - "slavebuilddir": "test" 12:39:27 INFO - } 12:39:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 12:39:27 INFO - Running post-action listener: _resource_record_post_action 12:39:27 INFO - ##### 12:39:27 INFO - ##### Finished read-buildbot-config step (success) 12:39:27 INFO - ##### 12:39:27 INFO - ##### 12:39:27 INFO - ##### Running download-and-extract step. 12:39:27 INFO - ##### 12:39:27 INFO - Running pre-action listener: _resource_record_pre_action 12:39:27 INFO - Running main action method: download_and_extract 12:39:27 INFO - mkdir: /builds/slave/test/build/tests 12:39:27 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')]} 12:39:27 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:39:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:39:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:39:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:39:32 INFO - Downloaded 1361 bytes. 12:39:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:39:32 INFO - Using the following test package requirements: 12:39:32 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:39:32 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:32 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:39:32 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'jsshell-linux-x86_64.zip'], 12:39:32 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:32 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:39:32 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:39:32 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:39:32 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:32 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:39:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:32 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:32 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')]} 12:39:32 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:35 INFO - Downloaded 24473137 bytes. 12:39:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:39:36 INFO - Return code: 0 12:39:36 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:39:36 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')]} 12:39:36 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:39:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:39:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:46 INFO - Downloaded 24473137 bytes. 12:39:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:39:47 INFO - Return code: 0 12:39:47 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')]} 12:39:47 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:39:48 INFO - Downloaded 10833369 bytes. 12:39:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:39:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:39:49 INFO - Return code: 0 12:39:49 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')]} 12:39:49 INFO - https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:39:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:39:50 INFO - Downloaded 63617112 bytes. 12:39:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:50 INFO - mkdir: /builds/slave/test/properties 12:39:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:39:50 INFO - Writing to file /builds/slave/test/properties/build_url 12:39:50 INFO - Contents: 12:39:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:39:51 INFO - Running post-action listener: _resource_record_post_action 12:39:51 INFO - Running post-action listener: set_extra_try_arguments 12:39:51 INFO - ##### 12:39:51 INFO - ##### Finished download-and-extract step (success) 12:39:51 INFO - ##### 12:39:51 INFO - ##### 12:39:51 INFO - ##### Running populate-webroot step. 12:39:51 INFO - ##### 12:39:51 INFO - Running pre-action listener: _resource_record_pre_action 12:39:51 INFO - Running main action method: populate_webroot 12:39:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:51 INFO - '--tppagecycles', 12:39:51 INFO - '7'], 12:39:51 INFO - 'tests': ['tsvgm']}}, 12:39:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:39:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:39:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:39:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['damp', 'tps']}, 12:39:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'tests': ['damp', 'tps']}, 12:39:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['dromaeo_dom']}, 12:39:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other-e10s': {'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['a11yr', 12:39:51 INFO - 'ts_paint', 12:39:51 INFO - 'tpaint', 12:39:51 INFO - 'sessionrestore', 12:39:51 INFO - 'sessionrestore_no_auto_restore', 12:39:51 INFO - 'tabpaint']}, 12:39:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tsvgx', 12:39:51 INFO - 'tsvgr_opacity', 12:39:51 INFO - 'tart', 12:39:51 INFO - 'tscrollx', 12:39:51 INFO - 'cart']}, 12:39:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:39:51 INFO - 'tsvgr_opacity', 12:39:51 INFO - 'tart', 12:39:51 INFO - 'tscrollx', 12:39:51 INFO - 'cart']}, 12:39:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s'], 12:39:51 INFO - 'tests': ['tp5o']}, 12:39:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'tests': ['tp5o']}, 12:39:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--disable-e10s', 12:39:51 INFO - '--xperf_path', 12:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:51 INFO - 'tests': ['tp5n']}, 12:39:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:51 INFO - 'talos_options': ['--xperf_path', 12:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:51 INFO - 'tests': ['tp5n']}}, 12:39:51 INFO - 'talos.zip': {'path': '', 12:39:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:51 INFO - Running post-action listener: _resource_record_post_action 12:39:51 INFO - ##### 12:39:51 INFO - ##### Finished populate-webroot step (success) 12:39:51 INFO - ##### 12:39:51 INFO - ##### 12:39:51 INFO - ##### Running create-virtualenv step. 12:39:51 INFO - ##### 12:39:51 INFO - Running pre-action listener: _resource_record_pre_action 12:39:51 INFO - Running main action method: create_virtualenv 12:39:51 INFO - Creating virtualenv /builds/slave/test/build/venv 12:39:51 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 12:39:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:39:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:51 INFO - Using real prefix '/usr' 12:39:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:39:51 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:53 INFO - Installing pip.................done. 12:39:53 INFO - Return code: 0 12:39:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:39: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', 'pip>=1.5'] in /builds/slave/test/build 12:39: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 pip>=1.5 12:39:53 INFO - Using env: {'DISPLAY': ':0', 12:39:53 INFO - 'HOME': '/home/cltbld', 12:39:53 INFO - 'LANG': 'en_US.UTF-8', 12:39:53 INFO - 'LANGUAGE': 'en_US:en', 12:39:53 INFO - 'LOGNAME': 'cltbld', 12:39:53 INFO - 'MAIL': '/var/mail/cltbld', 12:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:53 INFO - 'MOZ_NO_REMOTE': '1', 12:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:53 INFO - 'NO_EM_RESTART': '1', 12:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:53 INFO - 'PWD': '/builds/slave/test', 12:39:53 INFO - 'SHELL': '/bin/bash', 12:39:53 INFO - 'SHLVL': '1', 12:39:53 INFO - 'TERM': 'linux', 12:39:53 INFO - 'TMOUT': '86400', 12:39:53 INFO - 'USER': 'cltbld', 12:39:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:53 INFO - '_': '/tools/buildbot/bin/python'} 12:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:53 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 12:39:53 INFO - Cleaning up... 12:39:53 INFO - Return code: 0 12:39:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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', '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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:39: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 psutil>=3.1.1 12:39:53 INFO - Using env: {'DISPLAY': ':0', 12:39:53 INFO - 'HOME': '/home/cltbld', 12:39:53 INFO - 'LANG': 'en_US.UTF-8', 12:39:53 INFO - 'LANGUAGE': 'en_US:en', 12:39:53 INFO - 'LOGNAME': 'cltbld', 12:39:53 INFO - 'MAIL': '/var/mail/cltbld', 12:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:53 INFO - 'MOZ_NO_REMOTE': '1', 12:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:53 INFO - 'NO_EM_RESTART': '1', 12:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:53 INFO - 'PWD': '/builds/slave/test', 12:39:53 INFO - 'SHELL': '/bin/bash', 12:39:53 INFO - 'SHLVL': '1', 12:39:53 INFO - 'TERM': 'linux', 12:39:53 INFO - 'TMOUT': '86400', 12:39:53 INFO - 'USER': 'cltbld', 12:39:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:53 INFO - '_': '/tools/buildbot/bin/python'} 12:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:54 INFO - Downloading/unpacking psutil>=3.1.1 12:39:54 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 12:39:54 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 12:39:54 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 12:39:54 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 12:39:54 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 12:39:54 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 12:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:56 INFO - Installing collected packages: psutil 12:39:56 INFO - Running setup.py install for psutil 12:39:56 INFO - building 'psutil._psutil_linux' extension 12:39:56 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 12:39:56 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 12:39:56 INFO - building 'psutil._psutil_posix' extension 12:39:56 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 12:39:56 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 12:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:56 INFO - Successfully installed psutil 12:39:56 INFO - Cleaning up... 12:39:56 INFO - Return code: 0 12:39:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:39:56 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')]} 12:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:56 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')]} 12:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:56 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:39:56 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 12:39:56 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 12:39:56 INFO - Using env: {'DISPLAY': ':0', 12:39:56 INFO - 'HOME': '/home/cltbld', 12:39:56 INFO - 'LANG': 'en_US.UTF-8', 12:39:56 INFO - 'LANGUAGE': 'en_US:en', 12:39:56 INFO - 'LOGNAME': 'cltbld', 12:39:56 INFO - 'MAIL': '/var/mail/cltbld', 12:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:56 INFO - 'MOZ_NO_REMOTE': '1', 12:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:56 INFO - 'NO_EM_RESTART': '1', 12:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:56 INFO - 'PWD': '/builds/slave/test', 12:39:56 INFO - 'SHELL': '/bin/bash', 12:39:56 INFO - 'SHLVL': '1', 12:39:56 INFO - 'TERM': 'linux', 12:39:56 INFO - 'TMOUT': '86400', 12:39:56 INFO - 'USER': 'cltbld', 12:39:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:56 INFO - '_': '/tools/buildbot/bin/python'} 12:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:39:56 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 12:39:56 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 12:39:56 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 12:39:56 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 12:39:56 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 12:39:56 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 12:39:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:39:58 INFO - Installing collected packages: mozsystemmonitor 12:39:58 INFO - Running setup.py install for mozsystemmonitor 12:39:58 INFO - Successfully installed mozsystemmonitor 12:39:58 INFO - Cleaning up... 12:39:59 INFO - Return code: 0 12:39:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:39:59 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')]} 12:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:59 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')]} 12:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:59 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:39:59 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 12:39:59 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 12:39:59 INFO - Using env: {'DISPLAY': ':0', 12:39:59 INFO - 'HOME': '/home/cltbld', 12:39:59 INFO - 'LANG': 'en_US.UTF-8', 12:39:59 INFO - 'LANGUAGE': 'en_US:en', 12:39:59 INFO - 'LOGNAME': 'cltbld', 12:39:59 INFO - 'MAIL': '/var/mail/cltbld', 12:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:59 INFO - 'MOZ_NO_REMOTE': '1', 12:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:59 INFO - 'NO_EM_RESTART': '1', 12:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:59 INFO - 'PWD': '/builds/slave/test', 12:39:59 INFO - 'SHELL': '/bin/bash', 12:39:59 INFO - 'SHLVL': '1', 12:39:59 INFO - 'TERM': 'linux', 12:39:59 INFO - 'TMOUT': '86400', 12:39:59 INFO - 'USER': 'cltbld', 12:39:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:59 INFO - '_': '/tools/buildbot/bin/python'} 12:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:59 INFO - Downloading/unpacking jsonschema==2.5.1 12:39:59 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 12:39:59 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 12:39:59 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 12:39:59 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 12:39:59 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 12:39:59 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 12:40:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:40:01 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 12:40:01 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 12:40:01 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 12:40:01 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 12:40:01 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 12:40:01 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 12:40:01 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:01 INFO - warning: no files found matching '*.txt' 12:40:01 INFO - no previously-included directories found matching 'build' 12:40:01 INFO - no previously-included directories found matching 'dist' 12:40:01 INFO - no previously-included directories found matching '.git*' 12:40:01 INFO - Installing collected packages: jsonschema, functools32 12:40:01 INFO - Running setup.py install for functools32 12:40:01 INFO - warning: no files found matching '*.txt' 12:40:01 INFO - no previously-included directories found matching 'build' 12:40:01 INFO - no previously-included directories found matching 'dist' 12:40:01 INFO - no previously-included directories found matching '.git*' 12:40:01 INFO - Successfully installed jsonschema functools32 12:40:01 INFO - Cleaning up... 12:40:01 INFO - Return code: 0 12:40:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:01 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:40:01 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 12:40:01 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 12:40:01 INFO - Using env: {'DISPLAY': ':0', 12:40:01 INFO - 'HOME': '/home/cltbld', 12:40:01 INFO - 'LANG': 'en_US.UTF-8', 12:40:01 INFO - 'LANGUAGE': 'en_US:en', 12:40:01 INFO - 'LOGNAME': 'cltbld', 12:40:01 INFO - 'MAIL': '/var/mail/cltbld', 12:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:01 INFO - 'MOZ_NO_REMOTE': '1', 12:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:01 INFO - 'NO_EM_RESTART': '1', 12:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:01 INFO - 'PWD': '/builds/slave/test', 12:40:01 INFO - 'SHELL': '/bin/bash', 12:40:01 INFO - 'SHLVL': '1', 12:40:01 INFO - 'TERM': 'linux', 12:40:01 INFO - 'TMOUT': '86400', 12:40:01 INFO - 'USER': 'cltbld', 12:40:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:01 INFO - '_': '/tools/buildbot/bin/python'} 12:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:01 INFO - Downloading/unpacking blobuploader==1.2.4 12:40:01 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 12:40:01 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 12:40:01 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 12:40:01 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 12:40:01 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 12:40:01 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 12:40:03 INFO - Downloading blobuploader-1.2.4.tar.gz 12:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:40:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:40:03 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 12:40:03 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 12:40:03 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 12:40:03 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 12:40:03 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 12:40:03 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 12:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 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 12:40:04 INFO - Downloading docopt-0.6.1.tar.gz 12:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:04 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:04 INFO - Running setup.py install for blobuploader 12:40:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:04 INFO - Running setup.py install for requests 12:40:05 INFO - Running setup.py install for docopt 12:40:05 INFO - Successfully installed blobuploader requests docopt 12:40:05 INFO - Cleaning up... 12:40:05 INFO - Return code: 0 12:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:05 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')]} 12:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:05 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')]} 12:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:05 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:40:05 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 12:40:05 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 12:40:05 INFO - Using env: {'DISPLAY': ':0', 12:40:05 INFO - 'HOME': '/home/cltbld', 12:40:05 INFO - 'LANG': 'en_US.UTF-8', 12:40:05 INFO - 'LANGUAGE': 'en_US:en', 12:40:05 INFO - 'LOGNAME': 'cltbld', 12:40:05 INFO - 'MAIL': '/var/mail/cltbld', 12:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:05 INFO - 'MOZ_NO_REMOTE': '1', 12:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:05 INFO - 'NO_EM_RESTART': '1', 12:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:05 INFO - 'PWD': '/builds/slave/test', 12:40:05 INFO - 'SHELL': '/bin/bash', 12:40:05 INFO - 'SHLVL': '1', 12:40:05 INFO - 'TERM': 'linux', 12:40:05 INFO - 'TMOUT': '86400', 12:40:05 INFO - 'USER': 'cltbld', 12:40:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:05 INFO - '_': '/tools/buildbot/bin/python'} 12:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:05 INFO - Running setup.py (path:/tmp/pip-8x7wt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:05 INFO - Running setup.py (path:/tmp/pip-11O1by-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:05 INFO - Running setup.py (path:/tmp/pip-Jf7IZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:05 INFO - Running setup.py (path:/tmp/pip-NiXLhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:05 INFO - Running setup.py (path:/tmp/pip-PYZyKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:05 INFO - Running setup.py (path:/tmp/pip-Jp11Sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:05 INFO - Running setup.py (path:/tmp/pip-AumLkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:05 INFO - Running setup.py (path:/tmp/pip-UbyhAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:06 INFO - Running setup.py (path:/tmp/pip-cW85fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:06 INFO - Running setup.py (path:/tmp/pip-_qfB27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:06 INFO - Running setup.py (path:/tmp/pip-rHoegD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:06 INFO - Running setup.py (path:/tmp/pip-xlYwxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:06 INFO - Running setup.py (path:/tmp/pip-dPpQHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:06 INFO - Running setup.py (path:/tmp/pip-PzmZ3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:06 INFO - Running setup.py (path:/tmp/pip-yiX7qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:06 INFO - Running setup.py (path:/tmp/pip-kBJRoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:06 INFO - Running setup.py (path:/tmp/pip-59noS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:40:06 INFO - Running setup.py install for manifestparser 12:40:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:40:06 INFO - Running setup.py install for mozcrash 12:40:06 INFO - Running setup.py install for mozdebug 12:40:06 INFO - Running setup.py install for mozdevice 12:40:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Running setup.py install for mozfile 12:40:07 INFO - Running setup.py install for mozhttpd 12:40:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Running setup.py install for mozinfo 12:40:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Running setup.py install for mozInstall 12:40:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Running setup.py install for mozleak 12:40:07 INFO - Running setup.py install for mozlog 12:40:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Running setup.py install for moznetwork 12:40:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Running setup.py install for mozprocess 12:40:07 INFO - Running setup.py install for mozprofile 12:40:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:40:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:40:08 INFO - Running setup.py install for mozrunner 12:40:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:40:08 INFO - Running setup.py install for mozscreenshot 12:40:08 INFO - Running setup.py install for moztest 12:40:08 INFO - Running setup.py install for mozversion 12:40:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:40:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:40:08 INFO - Cleaning up... 12:40:08 INFO - Return code: 0 12:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:08 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:40:08 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 12:40:08 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 12:40:08 INFO - Using env: {'DISPLAY': ':0', 12:40:08 INFO - 'HOME': '/home/cltbld', 12:40:08 INFO - 'LANG': 'en_US.UTF-8', 12:40:08 INFO - 'LANGUAGE': 'en_US:en', 12:40:08 INFO - 'LOGNAME': 'cltbld', 12:40:08 INFO - 'MAIL': '/var/mail/cltbld', 12:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:08 INFO - 'MOZ_NO_REMOTE': '1', 12:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:08 INFO - 'NO_EM_RESTART': '1', 12:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:08 INFO - 'PWD': '/builds/slave/test', 12:40:08 INFO - 'SHELL': '/bin/bash', 12:40:08 INFO - 'SHLVL': '1', 12:40:08 INFO - 'TERM': 'linux', 12:40:08 INFO - 'TMOUT': '86400', 12:40:08 INFO - 'USER': 'cltbld', 12:40:08 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:08 INFO - '_': '/tools/buildbot/bin/python'} 12:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:08 INFO - Running setup.py (path:/tmp/pip-_kwiKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:08 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)) 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:08 INFO - Running setup.py (path:/tmp/pip-d3xEFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:08 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)) 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:08 INFO - Running setup.py (path:/tmp/pip-LUaaSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:08 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)) 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:08 INFO - Running setup.py (path:/tmp/pip-yhUDDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:08 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)) 12:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:08 INFO - Running setup.py (path:/tmp/pip-LG_7Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:09 INFO - Running setup.py (path:/tmp/pip-rWcV5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:09 INFO - Running setup.py (path:/tmp/pip-ff3A08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:09 INFO - Running setup.py (path:/tmp/pip-M5mHoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:09 INFO - Running setup.py (path:/tmp/pip-nSgyNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:09 INFO - Running setup.py (path:/tmp/pip-d2DBk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:09 INFO - Running setup.py (path:/tmp/pip-RpM1l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:09 INFO - Running setup.py (path:/tmp/pip-mgHLeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:09 INFO - Running setup.py (path:/tmp/pip-5l6V9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:40:09 INFO - Running setup.py (path:/tmp/pip-S4CmlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:09 INFO - Running setup.py (path:/tmp/pip-SVDlXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:40:09 INFO - Running setup.py (path:/tmp/pip-n7Uozo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:40:09 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)) 12:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:40:09 INFO - Running setup.py (path:/tmp/pip-NNL_IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:40:09 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)) 12:40:09 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)) 12:40:09 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)) 12:40:09 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)) 12:40:09 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)) 12:40:09 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)) 12:40:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40: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 12:40:11 INFO - Downloading blessings-1.6.tar.gz 12:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:40:11 INFO - Installing collected packages: blessings 12:40:11 INFO - Running setup.py install for blessings 12:40:11 INFO - Successfully installed blessings 12:40:11 INFO - Cleaning up... 12:40:12 INFO - Return code: 0 12:40:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:12 INFO - Reading from file tmpfile_stdout 12:40:12 INFO - Current package versions: 12:40:12 INFO - argparse == 1.2.1 12:40:12 INFO - blessings == 1.6 12:40:12 INFO - blobuploader == 1.2.4 12:40:12 INFO - docopt == 0.6.1 12:40:12 INFO - functools32 == 3.2.3-2 12:40:12 INFO - jsonschema == 2.5.1 12:40:12 INFO - manifestparser == 1.1 12:40:12 INFO - mozInstall == 1.12 12:40:12 INFO - mozcrash == 0.17 12:40:12 INFO - mozdebug == 0.1 12:40:12 INFO - mozdevice == 0.48 12:40:12 INFO - mozfile == 1.2 12:40:12 INFO - mozhttpd == 0.7 12:40:12 INFO - mozinfo == 0.9 12:40:12 INFO - mozleak == 0.1 12:40:12 INFO - mozlog == 3.2 12:40:12 INFO - moznetwork == 0.27 12:40:12 INFO - mozprocess == 0.22 12:40:12 INFO - mozprofile == 0.28 12:40:12 INFO - mozrunner == 6.11 12:40:12 INFO - mozscreenshot == 0.1 12:40:12 INFO - mozsystemmonitor == 0.3 12:40:12 INFO - moztest == 0.7 12:40:12 INFO - mozversion == 1.4 12:40:12 INFO - psutil == 3.1.1 12:40:12 INFO - requests == 1.2.3 12:40:12 INFO - wsgiref == 0.1.2 12:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:12 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')]} 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 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')]} 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:40:12 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 12:40:12 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 12:40:12 INFO - Using env: {'DISPLAY': ':0', 12:40:12 INFO - 'HOME': '/home/cltbld', 12:40:12 INFO - 'LANG': 'en_US.UTF-8', 12:40:12 INFO - 'LANGUAGE': 'en_US:en', 12:40:12 INFO - 'LOGNAME': 'cltbld', 12:40:12 INFO - 'MAIL': '/var/mail/cltbld', 12:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:12 INFO - 'MOZ_NO_REMOTE': '1', 12:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:12 INFO - 'NO_EM_RESTART': '1', 12:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:12 INFO - 'PWD': '/builds/slave/test', 12:40:12 INFO - 'SHELL': '/bin/bash', 12:40:12 INFO - 'SHLVL': '1', 12:40:12 INFO - 'TERM': 'linux', 12:40:12 INFO - 'TMOUT': '86400', 12:40:12 INFO - 'USER': 'cltbld', 12:40:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:12 INFO - '_': '/tools/buildbot/bin/python'} 12:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 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)) 12:40:12 INFO - Cleaning up... 12:40:12 INFO - Return code: 0 12:40:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:40:12 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')]} 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 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')]} 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:40:12 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 12:40:12 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 12:40:12 INFO - Using env: {'DISPLAY': ':0', 12:40:12 INFO - 'HOME': '/home/cltbld', 12:40:12 INFO - 'LANG': 'en_US.UTF-8', 12:40:12 INFO - 'LANGUAGE': 'en_US:en', 12:40:12 INFO - 'LOGNAME': 'cltbld', 12:40:12 INFO - 'MAIL': '/var/mail/cltbld', 12:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:12 INFO - 'MOZ_NO_REMOTE': '1', 12:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:12 INFO - 'NO_EM_RESTART': '1', 12:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:12 INFO - 'PWD': '/builds/slave/test', 12:40:12 INFO - 'SHELL': '/bin/bash', 12:40:12 INFO - 'SHLVL': '1', 12:40:12 INFO - 'TERM': 'linux', 12:40:12 INFO - 'TMOUT': '86400', 12:40:12 INFO - 'USER': 'cltbld', 12:40:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:12 INFO - '_': '/tools/buildbot/bin/python'} 12:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:40:12 INFO - Cleaning up... 12:40:12 INFO - Return code: 0 12:40:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:40:12 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')]} 12:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 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')]} 12:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:12 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 0x7f7c970d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, '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': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', '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 12:40:12 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 12:40:12 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 12:40:12 INFO - Using env: {'DISPLAY': ':0', 12:40:12 INFO - 'HOME': '/home/cltbld', 12:40:12 INFO - 'LANG': 'en_US.UTF-8', 12:40:12 INFO - 'LANGUAGE': 'en_US:en', 12:40:12 INFO - 'LOGNAME': 'cltbld', 12:40:12 INFO - 'MAIL': '/var/mail/cltbld', 12:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:12 INFO - 'MOZ_NO_REMOTE': '1', 12:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:12 INFO - 'NO_EM_RESTART': '1', 12:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:12 INFO - 'PWD': '/builds/slave/test', 12:40:12 INFO - 'SHELL': '/bin/bash', 12:40:12 INFO - 'SHLVL': '1', 12:40:12 INFO - 'TERM': 'linux', 12:40:12 INFO - 'TMOUT': '86400', 12:40:12 INFO - 'USER': 'cltbld', 12:40:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:12 INFO - '_': '/tools/buildbot/bin/python'} 12:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:12 INFO - Downloading/unpacking flake8 12:40:12 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 12:40:12 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 12:40:12 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 12:40:12 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 12:40:12 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 12:40:12 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 12:40:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:40:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:40:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:14 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 12:40:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:40:15 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 12:40:15 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 12:40:15 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 12:40:15 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 12:40:15 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 12:40:15 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 12:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:15 INFO - no previously-included directories found matching 'docs/_build' 12:40:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:40:15 INFO - Running setup.py install for pep8 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:40:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:40:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:40:15 INFO - no previously-included directories found matching 'docs/_build' 12:40:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:40:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:40:15 INFO - Cleaning up... 12:40:15 INFO - Return code: 0 12:40:15 INFO - Running post-action listener: _resource_record_post_action 12:40:15 INFO - Running post-action listener: _start_resource_monitoring 12:40:15 INFO - Starting resource monitoring. 12:40:15 INFO - ##### 12:40:15 INFO - ##### Finished create-virtualenv step (success) 12:40:15 INFO - ##### 12:40:15 INFO - ##### 12:40:15 INFO - ##### Running install step. 12:40:15 INFO - ##### 12:40:15 INFO - Running pre-action listener: _resource_record_pre_action 12:40:15 INFO - Running main action method: install 12:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:40:15 INFO - Reading from file tmpfile_stdout 12:40:15 INFO - Detecting whether we're running mozinstall >=1.0... 12:40:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:40:16 INFO - Reading from file tmpfile_stdout 12:40:16 INFO - Output received: 12:40:16 INFO - Usage: mozinstall [options] installer 12:40:16 INFO - Options: 12:40:16 INFO - -h, --help show this help message and exit 12:40:16 INFO - -d DEST, --destination=DEST 12:40:16 INFO - Directory to install application into. [default: 12:40:16 INFO - "/builds/slave/test"] 12:40:16 INFO - --app=APP Application being installed. [default: firefox] 12:40:16 INFO - mkdir: /builds/slave/test/build/application 12:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:40:31 INFO - Reading from file tmpfile_stdout 12:40:31 INFO - Output received: 12:40:31 INFO - /builds/slave/test/build/application/firefox/firefox 12:40:31 INFO - Running post-action listener: _resource_record_post_action 12:40:31 INFO - ##### 12:40:31 INFO - ##### Finished install step (success) 12:40:31 INFO - ##### 12:40:31 INFO - ##### 12:40:31 INFO - ##### Running run-tests step. 12:40:31 INFO - ##### 12:40:31 INFO - Running pre-action listener: _resource_record_pre_action 12:40:31 INFO - Running main action method: run_tests 12:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:31 INFO - Python 2.7.3 12:40:31 INFO - Return code: 0 12:40:31 INFO - grabbing minidump binary from tooltool 12:40:31 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')]} 12:40:31 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 0xdf52e0>, '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 0xd61140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd615d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40:31 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 12:40:31 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 12:40:31 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 12:40:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:32 INFO - Return code: 0 12:40:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:40:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:40:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:40:32 INFO - Return code: 0 12:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 12:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 12:40:32 INFO - Using env: {'DISPLAY': ':0', 12:40:32 INFO - 'HOME': '/home/cltbld', 12:40:32 INFO - 'LANG': 'en_US.UTF-8', 12:40:32 INFO - 'LANGUAGE': 'en_US:en', 12:40:32 INFO - 'LOGNAME': 'cltbld', 12:40:32 INFO - 'MAIL': '/var/mail/cltbld', 12:40:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:32 INFO - 'MOZ_NO_REMOTE': '1', 12:40:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:40:32 INFO - 'NO_EM_RESTART': '1', 12:40:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:32 INFO - 'PWD': '/builds/slave/test', 12:40:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:32 INFO - 'SHELL': '/bin/bash', 12:40:32 INFO - 'SHLVL': '1', 12:40:32 INFO - 'TERM': 'linux', 12:40:32 INFO - 'TMOUT': '86400', 12:40:32 INFO - 'USER': 'cltbld', 12:40:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065', 12:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:32 INFO - '_': '/tools/buildbot/bin/python'} 12:40:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 12:40:33 INFO - mozversion application_buildid: 20160622100424 12:40:33 INFO - mozversion application_changeset: b463de85df02512c96e9e19087522c34b08fcd08 12:40:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:40:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:33 INFO - mozversion application_name: Firefox 12:40:33 INFO - mozversion application_remotingname: firefox-dev 12:40:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:40:33 INFO - mozversion application_vendor: Mozilla 12:40:33 INFO - mozversion application_version: 49.0a2 12:40:33 INFO - mozversion platform_buildid: 20160622100424 12:40:33 INFO - mozversion platform_changeset: b463de85df02512c96e9e19087522c34b08fcd08 12:40:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:40:33 INFO - mozversion platform_version: 49.0a2 12:40:33 INFO - using testdate: 1466624433 12:40:33 INFO - actual date: 1466624433 12:40:33 INFO - starting webserver on 'localhost:55620' 12:40:33 INFO - SUITE-START | Running 2 tests 12:40:33 INFO - TEST-START | dromaeo_css 12:40:33 INFO - operating with platform_type : linux_ 12:40:33 INFO - Initialising browser for dromaeo_css test... 12:40:33 INFO - TEST-INFO | started process 22653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzpGTl/profile http://localhost:55620/getInfo.html) 12:40:36 INFO - PROCESS | 22653 | __metrics Screen width/height:1600/1200 12:40:36 INFO - PROCESS | 22653 | colorDepth:24 12:40:36 INFO - PROCESS | 22653 | Browser inner width/height: 1024/697 12:40:36 INFO - PROCESS | 22653 | __metrics 12:40:38 ERROR - PROCESS | 22653 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:40:38 INFO - PROCESS | 22653 | console.error: PushService: 12:40:38 INFO - PROCESS | 22653 | stateChangeProcessEnqueue: Error transitioning state 12:40:38 INFO - PROCESS | 22653 | UnknownError 12:40:38 INFO - TEST-INFO | 22653: exit 0 12:40:38 INFO - Browser initialized. 12:40:38 INFO - Running cycle 1/1 for dromaeo_css test... 12:40:38 INFO - TEST-INFO | started process 22745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWzpGTl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:50 INFO - PROCESS | 22745 | RSS: Main: 148529152 12:40:50 INFO - PROCESS | 22745 | 12:41:42 INFO - PROCESS | 22745 | 1466624502326 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] 12:43:49 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:55620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55620/tests/dromaeo/cssquery-ext.html) 12:43:50 INFO - PROCESS | 22745 | RSS: Main: 248709120 12:43:50 INFO - PROCESS | 22745 | 12:46:52 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:55620/tests/dromaeo/cssquery-ext.html (next: http://localhost:55620/tests/dromaeo/cssquery-jquery.html) 12:46:53 INFO - PROCESS | 22745 | RSS: Main: 229638144 12:46:53 INFO - PROCESS | 22745 | 12:49:55 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:55620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55620/tests/dromaeo/cssquery-mootools.html) 12:49:55 INFO - PROCESS | 22745 | RSS: Main: 225632256 12:49:55 INFO - PROCESS | 22745 | 12:52:57 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:55620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55620/tests/dromaeo/cssquery-prototype.html) 12:52:58 INFO - PROCESS | 22745 | RSS: Main: 227794944 12:52:58 INFO - PROCESS | 22745 | 12:56:01 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:55620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55620/tests/dromaeo/cssquery-yui.html) 12:56:01 INFO - PROCESS | 22745 | RSS: Main: 218447872 12:56:01 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:55620/tests/dromaeo/cssquery-yui.html (next: http://localhost:55620/tests/dromaeo/cssquery-dojo.html) 12:59:04 INFO - PROCESS | 22745 | RSS: Main: 259301376 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | __start_tp_report 12:59:04 INFO - PROCESS | 22745 | _x_x_mozilla_page_load 12:59:04 INFO - PROCESS | 22745 | _x_x_mozilla_page_load_details 12:59:04 INFO - PROCESS | 22745 | |i|pagename|runs| 12:59:04 INFO - PROCESS | 22745 | |0;dojo.html;3360.1431634933087;3374.3588718143565;3399.0312760863158;3415.265717870657;3415.84628691709;5605.607607467474;5641.323041235052;5708.800191993281;5712.200291959129;5725.055365864632;5613.270274864272;5676.716164191795;5686.63036902601;5693.743781529831;5697.658140511572;4893.975530122344;4979.278004689318;5131.025105230013;5136.152534831757;5170.09523333417;5085.262636917645;5112.514311140454;5112.8977420451565;5164.922526162091;5242.842714718565;5125.538701516863;5128.205128205134;5152.175651895697;5231.607629427808;5236.345456817898;5164.070467315882;5234.8691282717855;5236.214567814839;5238.5809135269465;5258.658187217857;4997.750112494361;5007.173816320303;5015.22264049073;5042.016806722654;5123.641345105844;5564.638298510584;5584.553235741171;5590.049691552445;5593.300837395325;5622.353429355595;6041.335453100155;6054.8183554493435;6065.400843881873;6070.41320832688;6093.329733729286;5927.970360148215;6030.366811484775;6052.788152414689;6093.573449858512;6140.34210763096;5778.6243894147165;5779.826605201851;5779.913301300484;5791.362950075489;5792.333881603628;5905.173275741399;6258.530610204253;6262.3111457739615;6268.373162683695;6269.404406581368;5851.941480585139;5915.704214789243;5919.55603329752;5956.9873121569435;6001.219841420588;6048.304444988883;6085.148079268906;6090.20827292458;6093.268807743099;6099.84750381244;5822.039363505059;6008.6394816310285;6011.699415029231;6021.668808215591;6024.427679370453;5878.353381128072;5932.703364831741;5943.970280148572;5993.910091348634;6000.819975400745;4582.1293954148605;4583.885402864955;4587.220172570671;4588.082383523242;4607.285870690049;4077.857274995361;4097.959020409818;4110.547839737626;4110.958890411118;4128.298189307825;5768.682722450221;5771.336296325976;5786.623869448473;5840.182374467578;5903.468687818117;6175.197224360894;6180.5673602848265;6183.041628547582;6184.938150618526;6186.845328866814;5662.462066103713;5703.287089113861;5861.17943487912;5880.7353669085;5887.587868849139;5175.4824517548695;5226.425093239741;5229.111051121318;5232;5249;6284.968575157095;6287.811365659038;6291.465225455796;6291.465225455888;6295.748170073238;5903.881922361443;5929.288485381781;5949.405059494016;6003.909941350796;6046.879062418815;6217.782377616762;6229.750809967732;6234.9688251558455;6236.594621349598;6241.656708880873;5853.64878107315;5884.529237661062;5896.262967129109;5905.202797622438;5933.317668468008;5990.7004649768205;6002.849928751816;6059.909101363572;6099.66451845135;6117.188044311343;5931.1992880960515;5949.196858424058;5967.731452084753;5970.671613061323;5979.342272350125;5841.94158058414;5892.734826932884;5895;5898.469137777621;5955;5638.915416268677;5720.313562372542;5751.539876809761;5773.97113014449;5834.708264586839;5924.7037648118285;5933.169356290036;5952.642841429528;5958.314793798769;5958.34458209588;5575.2473416088305;5744.454276843693;5785.450382213683;5803.912941305968;5808.680522571299 12:59:04 INFO - PROCESS | 22745 | |1;ext.html;616.1774031667724;648.2674577727167;656.2158220925992;669.8559809640926;672.7645324136556;33305.66694333056;36350.454743178874;36389.63610363896;36419.45370819436;36499.452508212366;36504.81747591265;37202.813985930035;46270.76864615681;47697.52302476974;47943.520564794344;8801.119888011195;9006.774830629254;9019.95490022549;9020.052894446088;9025.864612030824;8824.249938755214;8900.910990890105;8909.95545022274;8916.15296546827;8916.598753056096;8466.66133354665;8651.740447786577;8653.826923461527;10888.40113793741;11149.609763658274;11036.392998385085;11090.445477726162;11098.167637427225;11103.44482775862;11109.72225694356;10826.296290741077;10863.945680271549;10893.237473376867;10900.672979810619;10902.672919812418;38084;42837.143257134994;43475.56524434747;43509.56490435087;47690.76154619239;3591.5331006969186;3614.710823134143;3630.3465376232266;3902.570717221103;4073.124278280184;34383.31233375319;34593.6540634593;34615.307693845985;34711.479327810106;35022.47466288008;4283.97858010711;4330.913381732379;4353.020570371673;4394.6923715339935;4496.033352829125;365339;365691;365946.9999999973;366257;366978;65823;65872.67063664651;66143;66285;66603.66698166575;61604.38395616076;61731.691341543;61820;61978;62002;17069.231884564975;17487.475375738748;17495.562610934572;17498.650026999643;17505.474835754947;14444.422223111169;14580.125192488485;14587.854121458862;14587.927060364631;14589;17398.130093495274;19469.51326216856;19527.511812204808;19555.608887822164;19608.90195549013;5873.148393482921;6210.9068363974575;6295.527835412271;6367.968160159262;6396.680165991775;1081.6484642491064;1148.534843388429;1191.267370567095;1222.6148763139583;1271.313490715022;33587.83206083954;34482.82758586241;35062.29875402478;35207.4718879217;35308.82345588256;1164.342146687136;1187.9703007424885;1190.2323001663879;1238.4674589926237;1337.8996575256895;17705;18421.355252566096;18436.354727584738;18449.81550184481;18636;569511;572937;575902;576272;576350;64341.35658643447;64735.67632161809;64851.67574162099;65026.34973650203;65141;1372.773492373767;1419.176877411099;1419.5670320552124;1455.2505459688268;1461.043016823982;32334.676653234106;33262.33475330431;33521.16197095092;33908;34077.48883766795;56979.43020569741;57193.142102867656;57311.42688573061;57338;57370.426295736506;475933;477990;479210;479443;479961;45992.7700361496;47392.763036184595;48708.75645621891;48731.02537949292;48755.75622121867;53296;53561.46438535565;53598.46401535935;54462;54869.45130548803;44913.77543112264;45091;45185.32222016607;45281.32078018898;46188.7690561545;44032.559674402844;44433.45521388992;44678.553214467436;45071.549284506735;45443.318350224115;44584.885377865816;45005.54994450013;45291.320630191236;45645.31532026956;45827.31259031184;36911.261774763814;39001.804990974866;39802.60197398105;40077.799611001756;40318;29325.56011659784;29640.258993525335;29947.401051978402;30151.849240753654;30162.849185754807 12:59:04 INFO - PROCESS | 22745 | |2;jquery.html;405.37976895350124;412.6059613069519;424.6878544269961;425.40230975479454;437.6476936066467;15466.845331546681;19729.408117756455;20244.59510809785;20249.58252922296;20936.790632093675;19781.703274450858;19822.108005139766;19854.801451985477;20010.799892001076;20095.497612559655;5555.722213889309;5794.6523208607405;5808.12878068289;5936.050231962887;5938.940610593882;5813.854653633672;5886;5890.911636325459;5912.408759124096;5913.586048976574;5654;5861.0915308127305;5874.530037596982;5877.2947246330505;5883.558733095014;5714;5774.913376299359;5822;5823.5341172706085;5845.532357411418;5810.82567522975;5861.648301101947;5886.676232807194;5887.234659494281;5892.263467066617;14677.192754398504;18448.354307599304;23472.64791028119;24278.635820462707;24316.63525047108;2056.845736569748;2063.0716177719937;2089.3836318286144;2172.652375619909;2351.3886389538843;10604.416757078357;10722.785544289149;10985.340879547173;11312.264702794291;14294.64263393413;1993.5514509235306;2091.9477013074793;2093.926712565053;2127.6914847347048;2168.8698678079368;53872.965348326215;54593.635159120946;56140.43859561393;56358;78509.60745196295;11568.652940411801;11605.129615278887;11745.765084698258;11764.529418823151;11775.882241177478;16250.674986500204;16251.59371015734;16312.67374652524;16334.918325408296;16371.263293151836;8638.481691098554;8841.513716745641;8896.957792030631;8897.688580899767;8915.910840891638;8489.235968762841;8527.147285271423;8611.655533778703;8641.179087986631;8654.048054713976;4699.224627936421;4763.904721905612;4784.282357646381;4922.1787938462285;4957.157283261854;1836.1800274280015;1857.1178690122083;1877.9718304225448;1887.8678492505667;1902.4958386027713;979.2019504104132;997.3915911294105;1049.1397054415306;1066.9679909602723;1147.1969621265148;19550.608987820164;19676.40970770879;19793.604127917362;19955.900220498803;20138.69791953122;994.7065615643403;994.9850752238722;1031.2781053262745;1032.3702541449709;1036.896310368972;10858.2399232053;11103.222774405715;11149.498272577754;11166.832497512543;11167.329960202414;502131;509255;515254;516257;531332;98738.50630746943;98889.50555247178;100752.49623751834;102075.48962255141;102672.48663756634;1001.6494227020485;1008.2186305613062;1012.4431562640518;1030.07808011829;1052.1319911073394;17460;17495.82504174942;17670.20484078245;17778;18193.818061819213;41636.79181604073;41896.581034189265;42730.78634606807;43746.34380484232;43814.34278485889;59873.70063149656;60649.69675151596;61108.69445652743;61201;62038.37961620326;8926.553672316488;9267.212286955684;9400.247980161434;9426.528673566432;9547.618095276111;12268.631941041784;13488.5279015234;13643.181409115485;13746.862531374958;14057.578272651837;11811.645650630495;11969.64091077269;12153.149279550347;12386.62840114798;12458.688532786753;8277.875831862406;11799.646010619696;11894.881051189377;12163.695907602381;12308.938455307667;11911.82132268034;12121.333326667118;12298.569550065704;12489.875101249234;12496.125271230927;7748.728794492165;9088;9171.77070573241;9210.95394523023;9267.582958766738;10508.737281568023;11812.169113787377;11883.405829708652;12080.154389192672;12216.205946613441 12:59:04 INFO - PROCESS | 22745 | |3;mootools.html;1470.9632259193513;1586.7540531217662;1616.046532545798;1795.2011354947047;1908.5514903997557;9341.673041443551;9743.025697430254;9782.364146330492;10036.397816131037;10048.547815348309;9680.080392362732;9892.703218903445;9894.307398482091;9907.851382229272;9909.504524773769;2179.259051922346;2514.4091138582417;2556.2203527923975;2580.213035024317;2586.6378706980945;2537.086648806428;2549.566573682469;2553.74462553745;2559.8720063996725;2559.8848051837617;2505.8245922785413;2529.911453099142;2533.3160046787357;2535.2140836340795;2536.4927014597156;2152.7847215278503;2499.2252401755422;2578.8065895057944;2583.522048421048;2595.8182927195103;2465.161844972718;2514.1828905605566;2515.396304886814;2554.1443616388533;2555.795536357087;9838.950805245999;9883.703488895344;9897.4556399398;9903.45530995795;9910.25673074515;5813.738381772788;5944.7027648617395;5954.851128721773;5954.8809023819285;5955.493783028448;3668.284684486526;3760.1351689111384;3769.3026790043928;3784.2053168834577;3826.1773718650625;1163.7209256103106;1176.9588064417703;1209.3711270139565;1219.3171823778712;1233.734747029384;14008.719825603534;14130.92934535331;14157.504487342894;14173.929130354281;14201.431942722278;5254.369475662945;5304.761285742151;5358.035553600389;5388.245645609618;5403.540699040625;11677.240979336486;11685.649430517098;11692.532298708127;11752;11806.40967951599;5317.361916570037;5970.761169553256;6046.486048685823;6054.697265136726;6057.636541807506;5375.220593013991;5511.669299842022;5517.200005999108;5530.142827861688;5533.667979921218;4477.8208871644765;4505.887352816206;4535.886602834956;4580.427446569179;4589.678722489393;1427.557457188275;1442.1058943455125;1465.0550394995169;1470.8308544517304;1470.9705805884037;936.3539157980971;962.2542529539522;1095.2606990281529;1106.551846502168;1108.3903852880883;6395.808125756234;6567.408933196035;6575.079488871562;6575.934240657532;6609;1019.4647809899861;1038.6364772329775;1040.6802300660868;1065.4566171252718;1090.6237348114887;4533.365328853963;4641.396618439581;4716.457607375196;4725.385699858996;4755.025219829927;12210.206336588093;12920.095593308566;12930.935345323212;12977.935110324388;13016.219026858229;12549.498020079278;12765.808512872314;12772.425240864184;12892.548760793326;12914.612561623166;8843.292536597186;8846.557672116369;8908.8663670045;8970.372073954892;8989.595468203946;6649.0691303218555;6654.83362915931;6675.132232809704;6689.397954184147;6766.15423072116;11323.943380283046;11382.373969431761;11632.709182270512;11656;11659.76680466369;11699.986047716999;11841.28952262867;11870.821937671115;12043.638690839289;12046.277223366276;7492;7656.196099409482;7661.387089032975;8285.4200205985;8435.493870367798;9030.729078127666;9310.72067837966;9465.716028519155;9530.809383812424;9793.902060979299;8517.403781735218;8567.100454452442;8586.742397727829;8620.78448038804;8683.435576687496;8507.319414446705;8534.061253262013;8731.694390696295;8733.56332183401;8873.778155545904;7728.652210650646;7762.961185194264;7825.765227043198;7838.843223135391;7843.7254696085365;5755.8561035974435;5904.704764761659;5916.142159386951;5970.164177015308;6104.053871649901;5630.127330263816;5634.126710359901;5655.4910058094965;5732.254806875247;5864.67744274052 12:59:04 INFO - PROCESS | 22745 | |4;prototype.html;361.74316235472816;369.88903329001295;373.19576313045394;374.69462388153636;382.22980693901775;5602.32772067352;5608.523275521576;5650.576206784493;5653.349864765548;5660.150977353399;5258.658187217838;5290.042684206839;5443;5472.480114389136;5549.250851135095;4317.15815415994;4336.349547567858;4342.218400687875;4346.413234213388;4365.017870979036;4372.256716358211;4396.934045989313;4409.096135292273;4438.134563760052;4446.1107778444275;4039.798010099498;4198.559151289117;4330.39374487572;4359.2371335016405;4372.475302963649;4299.50555686097;4322.82708691652;4335.978320108379;4357.237483440401;4363.170997510495;3893.260280546687;3898.3567711327596;3903.3754599264266;3911.7457365271453;3911.7848518331766;5127.230915362688;5228.529432351107;5230.535450073985;5317.574594032468;5319.739110877861;4888.9755551222015;4948.554630083274;4984.900301993976;5019.84940451787;5027.723475208862;5718.284514645589;5723.6246957512585;5727.255456790632;5751.712414379264;5752.424757524256;3959.940600890989;4191.7484950903045;4198.3702444633545;4199.91600167998;4240.279152544044;5931.199288096138;5951.226340575698;5958.612690175125;5978.701064946778;6004.159417681484;4334.349847522833;4340.218760623118;4347.261095561737;4349.869503914888;4351.998080882766;4228.1966426378885;4323.4379530661445;4329.480462344476;4349.586789255016;4383.539728328544;4892.2661600760175;4908.288298196741;4919.557239848359;4941.851744447672;4948.1835497142565;5737.160105747682;5784.537237021028;5785.88428231433;5813.854653633608;5829.134676903435;1420.6803469219342;1432.649000994763;1452.8038714773581;1462.8464011278875;1509.3736099518576;959.8320293948531;965.3098034905076;969.4377261188635;988.7429268390271;995.6117114325419;4995.275685025724;5042.512458824655;5089.745512724349;5106.727506259753;5123.7438128093445;5258.553022993012;5263.078961181778;5293.338332708411;5297.231901374356;5306.442823503477;4849.563539281411;5040.84877453677;5056.811649262494;5083.339165908408;5106.599898047912;2814.620026296465;2822.5201715707967;2827.4062446885973;2828.78784091194;2835.631367922157;5404.756785944642;5456.699881506476;5462.945370546323;5481.808136715196;5499.7250137492965;5125.308083408692;5366.316841579211;5366.6243362965;5372;5372.838814835562;5365.463453654604;5433.864153396196;5448.346198456211;5450.645708028966;5471.945280547223;5246.160614301693;5247.8163264287095;5265.921011184759;5277.868053298698;5327.588189129961;4925.187344088328;5087.2957559218075;5122.8975420492125;5170.759017835617;5224.9738751306;5264.736763161904;5349;5384.6769193848495;5422.918656220081;5464.316960379952;3909.0454772613693;3918.941215881707;3932.9213415732097;3958.6437220650278;3959.8812035638975;4960.851174464772;5254.106801843619;5270.657407268515;5271.894562108813;5721.082248053606;5680.693440508623;5809.157672137601;5810;5819.098039803837;5823.4467725566;5694.772209111589;5769.307683078057;5774.307083150049;5791.276090488689;5805.419458054161;5485.561155107502;5706.8573285666525;5762.567807414377;5769.30764310833;5785.681787501728;5795.565332599987;5801.82594522165;5808.215890854681;5822.796202132905;5846.093855452412;5497.972510137583;5683.77264909399;5705.600607957569;5745.9425405745405;5750.878578677118 12:59:04 INFO - PROCESS | 22745 | |5;yui.html;679.541309616009;733.5305404541094;745.2547452547452;796.2037962037964;822.2681813186265;14950.177740224284;15266.618334541641;15472.458463953764;15547.37810487582;15549.922250388747;15286.388544458236;15543.22283885804;15566.143862087582;15574.221288935565;15577.221138943065;717.2970488920861;825.1583384947351;854.2738672128703;860.3418384935529;869.76516340588;859.8538248497771;864.5979619476942;865.2558799432483;867.2628265973934;867.7526904832124;758.7192738686693;928.4754113925644;929.1544694328163;929.604917909889;929.869818225449;893.7676204186894;908.7001289574457;909.9408538445012;922.0917396364575;922.7139586728135;671.1509939925998;675.8986152077179;675.9155105611799;676.2696288008988;676.4216594811414;13083.149595276276;13101.410436530283;13154.868451315555;13224.471021159143;13228;14970.326335314938;15156.24218789056;15234.390624375012;15280;15482.690346193012;12212.511499540007;12260.81608775869;12361;13533.932330338384;14201.218932958684;4862.319275301461;4899;4927.926081108786;4935.284383764334;5043.5965122790085;77122.6143869277;77662.6116869412;77678.61160694217;78178;78360.60819695922;11761.941190293994;11861.525538978516;11914.523419063315;11960.700982475508;12088.09339299556;20791.168353266003;20967.685484717742;21022.684659730116;21035.8948205258;21040.789592103883;8936.374453788303;9007.81984360309;9013.324000699973;9015.413998090235;9083;4815.951840481621;5057.519535644108;5080.933004069113;5145.202493613496;5293.232481290268;3599.7480176387926;3685.5761587417255;3687.852485900534;3693.9445908311395;3700.40793473043;667.7095463473405;669.6049330894796;676.4284179868004;683.9452843772486;693.5214701855704;667.9365460281266;703.5426972467936;706.1314583062862;713;715.6529083394549;10125.291229614004;10232.948835255926;10257.794844103077;10329.431881246604;10338;734.9559026458429;745.9780101261307;746.7138624296499;750;762.0969151555424;4444.444444444444;4693;4714.38712967312;4782.3897991635195;4858.421013170733;96349;99593;101077;115427;118269;99605;100425;100901.49549252207;102443;102605;88572;94388;94728;95852;95984.52007739917;9818.852717209105;9881.950590247003;9972.152367048882;9999.503401698308;10037.799244015225;51156;52465.213021805466;52559.21161182662;52921;53840.461595383546;69208.70961168675;77178.2282177171;79056.20943790488;79757;80138;13226.272555009182;13375.933120334725;13414.463421463031;13690.178589284675;13794.37925293344;12539.74920501603;14426.278686065445;15894.364225430852;15982.760258596363;16279.51161465158;14385.784213237019;14506.637334066732;14705;14721.852781472047;14899.62750931192;14557.563273101823;14912.403503859725;14978;15053.774193387328;15332.386704531693;13859.445622175;14304.070235434663;14304.57086287413;14880.479183228535;15359.692806144038;12182.147249692436;12529.93735031319;12775;12916.93541532324;13212.273324966834;12209.267443953391;12365.196262242926;12441.986965157334;12456.31490268044;12565.371731413576 12:59:04 INFO - PROCESS | 22745 | __end_tp_report 12:59:04 INFO - PROCESS | 22745 | __start_cc_report 12:59:04 INFO - PROCESS | 22745 | _x_x_mozilla_cycle_collect,923 12:59:04 INFO - PROCESS | 22745 | __end_cc_report 12:59:04 INFO - PROCESS | 22745 | __startTimestamp1466625544302__endTimestamp 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | ------- Summary: start ------- 12:59:04 INFO - PROCESS | 22745 | Number of tests: 6 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | [#0] dojo.html Cycles:165 Average:5619.73 Median:5841.94 stddev:629.85 (10.8%) stddev-sans-first:606.32 12:59:04 INFO - PROCESS | 22745 | Values: 3360.1 3374.4 3399.0 3415.3 3415.8 5605.6 5641.3 5708.8 5712.2 5725.1 5613.3 5676.7 5686.6 5693.7 5697.7 4894.0 4979.3 5131.0 5136.2 5170.1 5085.3 5112.5 5112.9 5164.9 5242.8 5125.5 5128.2 5152.2 5231.6 5236.3 5164.1 5234.9 5236.2 5238.6 5258.7 4997.8 5007.2 5015.2 5042.0 5123.6 5564.6 5584.6 5590.0 5593.3 5622.4 6041.3 6054.8 6065.4 6070.4 6093.3 5928.0 6030.4 6052.8 6093.6 6140.3 5778.6 5779.8 5779.9 5791.4 5792.3 5905.2 6258.5 6262.3 6268.4 6269.4 5851.9 5915.7 5919.6 5957.0 6001.2 6048.3 6085.1 6090.2 6093.3 6099.8 5822.0 6008.6 6011.7 6021.7 6024.4 5878.4 5932.7 5944.0 5993.9 6000.8 4582.1 4583.9 4587.2 4588.1 4607.3 4077.9 4098.0 4110.5 4111.0 4128.3 5768.7 5771.3 5786.6 5840.2 5903.5 6175.2 6180.6 6183.0 6184.9 6186.8 5662.5 5703.3 5861.2 5880.7 5887.6 5175.5 5226.4 5229.1 5232.0 5249.0 6285.0 6287.8 6291.5 6291.5 6295.7 5903.9 5929.3 5949.4 6003.9 6046.9 6217.8 6229.8 6235.0 6236.6 6241.7 5853.6 5884.5 5896.3 5905.2 5933.3 5990.7 6002.8 6059.9 6099.7 6117.2 5931.2 5949.2 5967.7 5970.7 5979.3 5841.9 5892.7 5895.0 5898.5 5955.0 5638.9 5720.3 5751.5 5774.0 5834.7 5924.7 5933.2 5952.6 5958.3 5958.3 5575.2 5744.5 5785.5 5803.9 5808.7 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | [#1] ext.html Cycles:180 Average:64932.15 Median:23560.56 stddev:127355.53 (540.5%) stddev-sans-first:127621.24 12:59:04 INFO - PROCESS | 22745 | Values: 616.2 648.3 656.2 669.9 672.8 33305.7 36350.5 36389.6 36419.5 36499.5 36504.8 37202.8 46270.8 47697.5 47943.5 8801.1 9006.8 9020.0 9020.1 9025.9 8824.2 8900.9 8910.0 8916.2 8916.6 8466.7 8651.7 8653.8 10888.4 11149.6 11036.4 11090.4 11098.2 11103.4 11109.7 10826.3 10863.9 10893.2 10900.7 10902.7 38084.0 42837.1 43475.6 43509.6 47690.8 3591.5 3614.7 3630.3 3902.6 4073.1 34383.3 34593.7 34615.3 34711.5 35022.5 4284.0 4330.9 4353.0 4394.7 4496.0 365339.0 365691.0 365947.0 366257.0 366978.0 65823.0 65872.7 66143.0 66285.0 66603.7 61604.4 61731.7 61820.0 61978.0 62002.0 17069.2 17487.5 17495.6 17498.7 17505.5 14444.4 14580.1 14587.9 14587.9 14589.0 17398.1 19469.5 19527.5 19555.6 19608.9 5873.1 6210.9 6295.5 6368.0 6396.7 1081.6 1148.5 1191.3 1222.6 1271.3 33587.8 34482.8 35062.3 35207.5 35308.8 1164.3 1188.0 1190.2 1238.5 1337.9 17705.0 18421.4 18436.4 18449.8 18636.0 569511.0 572937.0 575902.0 576272.0 576350.0 64341.4 64735.7 64851.7 65026.3 65141.0 1372.8 1419.2 1419.6 1455.3 1461.0 32334.7 33262.3 33521.2 33908.0 34077.5 56979.4 57193.1 57311.4 57338.0 57370.4 475933.0 477990.0 479210.0 479443.0 479961.0 45992.8 47392.8 48708.8 48731.0 48755.8 53296.0 53561.5 53598.5 54462.0 54869.5 44913.8 45091.0 45185.3 45281.3 46188.8 44032.6 44433.5 44678.6 45071.5 45443.3 44584.9 45005.5 45291.3 45645.3 45827.3 36911.3 39001.8 39802.6 40077.8 40318.0 29325.6 29640.3 29947.4 30151.8 30162.8 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | [#2] jquery.html Cycles:180 Average:29658.60 Median:11532.24 stddev:84681.11 (734.3%) stddev-sans-first:84890.17 12:59:04 INFO - PROCESS | 22745 | Values: 405.4 412.6 424.7 425.4 437.6 15466.8 19729.4 20244.6 20249.6 20936.8 19781.7 19822.1 19854.8 20010.8 20095.5 5555.7 5794.7 5808.1 5936.1 5938.9 5813.9 5886.0 5890.9 5912.4 5913.6 5654.0 5861.1 5874.5 5877.3 5883.6 5714.0 5774.9 5822.0 5823.5 5845.5 5810.8 5861.6 5886.7 5887.2 5892.3 14677.2 18448.4 23472.6 24278.6 24316.6 2056.8 2063.1 2089.4 2172.7 2351.4 10604.4 10722.8 10985.3 11312.3 14294.6 1993.6 2091.9 2093.9 2127.7 2168.9 53873.0 54593.6 56140.4 56358.0 78509.6 11568.7 11605.1 11745.8 11764.5 11775.9 16250.7 16251.6 16312.7 16334.9 16371.3 8638.5 8841.5 8897.0 8897.7 8915.9 8489.2 8527.1 8611.7 8641.2 8654.0 4699.2 4763.9 4784.3 4922.2 4957.2 1836.2 1857.1 1878.0 1887.9 1902.5 979.2 997.4 1049.1 1067.0 1147.2 19550.6 19676.4 19793.6 19955.9 20138.7 994.7 995.0 1031.3 1032.4 1036.9 10858.2 11103.2 11149.5 11166.8 11167.3 502131.0 509255.0 515254.0 516257.0 531332.0 98738.5 98889.5 100752.5 102075.5 102672.5 1001.6 1008.2 1012.4 1030.1 1052.1 17460.0 17495.8 17670.2 17778.0 18193.8 41636.8 41896.6 42730.8 43746.3 43814.3 59873.7 60649.7 61108.7 61201.0 62038.4 8926.6 9267.2 9400.2 9426.5 9547.6 12268.6 13488.5 13643.2 13746.9 14057.6 11811.6 11969.6 12153.1 12386.6 12458.7 8277.9 11799.6 11894.9 12163.7 12308.9 11911.8 12121.3 12298.6 12489.9 12496.1 7748.7 9088.0 9171.8 9211.0 9267.6 10508.7 11812.2 11883.4 12080.2 12216.2 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | [#3] mootools.html Cycles:180 Average:6533.53 Median:4615.54 stddev:3793.45 (82.2%) stddev-sans-first:3785.01 12:59:04 INFO - PROCESS | 22745 | Values: 1471.0 1586.8 1616.0 1795.2 1908.6 9341.7 9743.0 9782.4 10036.4 10048.5 9680.1 9892.7 9894.3 9907.9 9909.5 2179.3 2514.4 2556.2 2580.2 2586.6 2537.1 2549.6 2553.7 2559.9 2559.9 2505.8 2529.9 2533.3 2535.2 2536.5 2152.8 2499.2 2578.8 2583.5 2595.8 2465.2 2514.2 2515.4 2554.1 2555.8 9839.0 9883.7 9897.5 9903.5 9910.3 5813.7 5944.7 5954.9 5954.9 5955.5 3668.3 3760.1 3769.3 3784.2 3826.2 1163.7 1177.0 1209.4 1219.3 1233.7 14008.7 14130.9 14157.5 14173.9 14201.4 5254.4 5304.8 5358.0 5388.2 5403.5 11677.2 11685.6 11692.5 11752.0 11806.4 5317.4 5970.8 6046.5 6054.7 6057.6 5375.2 5511.7 5517.2 5530.1 5533.7 4477.8 4505.9 4535.9 4580.4 4589.7 1427.6 1442.1 1465.1 1470.8 1471.0 936.4 962.3 1095.3 1106.6 1108.4 6395.8 6567.4 6575.1 6575.9 6609.0 1019.5 1038.6 1040.7 1065.5 1090.6 4533.4 4641.4 4716.5 4725.4 4755.0 12210.2 12920.1 12930.9 12977.9 13016.2 12549.5 12765.8 12772.4 12892.5 12914.6 8843.3 8846.6 8908.9 8970.4 8989.6 6649.1 6654.8 6675.1 6689.4 6766.2 11323.9 11382.4 11632.7 11656.0 11659.8 11700.0 11841.3 11870.8 12043.6 12046.3 7492.0 7656.2 7661.4 8285.4 8435.5 9030.7 9310.7 9465.7 9530.8 9793.9 8517.4 8567.1 8586.7 8620.8 8683.4 8507.3 8534.1 8731.7 8733.6 8873.8 7728.7 7763.0 7825.8 7838.8 7843.7 5755.9 5904.7 5916.1 5970.2 6104.1 5630.1 5634.1 5655.5 5732.3 5864.7 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | [#4] prototype.html Cycles:180 Average:4686.46 Median:5246.99 stddev:1333.86 (25.4%) stddev-sans-first:1297.50 12:59:04 INFO - PROCESS | 22745 | Values: 361.7 369.9 373.2 374.7 382.2 5602.3 5608.5 5650.6 5653.3 5660.2 5258.7 5290.0 5443.0 5472.5 5549.3 4317.2 4336.3 4342.2 4346.4 4365.0 4372.3 4396.9 4409.1 4438.1 4446.1 4039.8 4198.6 4330.4 4359.2 4372.5 4299.5 4322.8 4336.0 4357.2 4363.2 3893.3 3898.4 3903.4 3911.7 3911.8 5127.2 5228.5 5230.5 5317.6 5319.7 4889.0 4948.6 4984.9 5019.8 5027.7 5718.3 5723.6 5727.3 5751.7 5752.4 3959.9 4191.7 4198.4 4199.9 4240.3 5931.2 5951.2 5958.6 5978.7 6004.2 4334.3 4340.2 4347.3 4349.9 4352.0 4228.2 4323.4 4329.5 4349.6 4383.5 4892.3 4908.3 4919.6 4941.9 4948.2 5737.2 5784.5 5785.9 5813.9 5829.1 1420.7 1432.6 1452.8 1462.8 1509.4 959.8 965.3 969.4 988.7 995.6 4995.3 5042.5 5089.7 5106.7 5123.7 5258.6 5263.1 5293.3 5297.2 5306.4 4849.6 5040.8 5056.8 5083.3 5106.6 2814.6 2822.5 2827.4 2828.8 2835.6 5404.8 5456.7 5462.9 5481.8 5499.7 5125.3 5366.3 5366.6 5372.0 5372.8 5365.5 5433.9 5448.3 5450.6 5471.9 5246.2 5247.8 5265.9 5277.9 5327.6 4925.2 5087.3 5122.9 5170.8 5225.0 5264.7 5349.0 5384.7 5422.9 5464.3 3909.0 3918.9 3932.9 3958.6 3959.9 4960.9 5254.1 5270.7 5271.9 5721.1 5680.7 5809.2 5810.0 5819.1 5823.4 5694.8 5769.3 5774.3 5791.3 5805.4 5485.6 5706.9 5762.6 5769.3 5785.7 5795.6 5801.8 5808.2 5822.8 5846.1 5498.0 5683.8 5705.6 5745.9 5750.9 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - PROCESS | 22745 | [#5] yui.html Cycles:180 Average:21283.61 Median:4748.39 stddev:30020.75 (632.2%) stddev-sans-first:30065.10 12:59:04 INFO - PROCESS | 22745 | Values: 679.5 733.5 745.3 796.2 822.3 14950.2 15266.6 15472.5 15547.4 15549.9 15286.4 15543.2 15566.1 15574.2 15577.2 717.3 825.2 854.3 860.3 869.8 859.9 864.6 865.3 867.3 867.8 758.7 928.5 929.2 929.6 929.9 893.8 908.7 909.9 922.1 922.7 671.2 675.9 675.9 676.3 676.4 13083.1 13101.4 13154.9 13224.5 13228.0 14970.3 15156.2 15234.4 15280.0 15482.7 12212.5 12260.8 12361.0 13533.9 14201.2 4862.3 4899.0 4927.9 4935.3 5043.6 77122.6 77662.6 77678.6 78178.0 78360.6 11761.9 11861.5 11914.5 11960.7 12088.1 20791.2 20967.7 21022.7 21035.9 21040.8 8936.4 9007.8 9013.3 9015.4 9083.0 4816.0 5057.5 5080.9 5145.2 5293.2 3599.7 3685.6 3687.9 3693.9 3700.4 667.7 669.6 676.4 683.9 693.5 667.9 703.5 706.1 713.0 715.7 10125.3 10232.9 10257.8 10329.4 10338.0 735.0 746.0 746.7 750.0 762.1 4444.4 4693.0 4714.4 4782.4 4858.4 96349.0 99593.0 101077.0 115427.0 118269.0 99605.0 100425.0 100901.5 102443.0 102605.0 88572.0 94388.0 94728.0 95852.0 95984.5 9818.9 9882.0 9972.2 9999.5 10037.8 51156.0 52465.2 52559.2 52921.0 53840.5 69208.7 77178.2 79056.2 79757.0 80138.0 13226.3 13375.9 13414.5 13690.2 13794.4 12539.7 14426.3 15894.4 15982.8 16279.5 14385.8 14506.6 14705.0 14721.9 14899.6 14557.6 14912.4 14978.0 15053.8 15332.4 13859.4 14304.1 14304.6 14880.5 15359.7 12182.1 12529.9 12775.0 12916.9 13212.3 12209.3 12365.2 12442.0 12456.3 12565.4 12:59:04 INFO - PROCESS | 22745 | -------- Summary: end -------- 12:59:04 INFO - PROCESS | 22745 | 12:59:04 INFO - TEST-INFO | 22745: exit 0 12:59:04 INFO - TEST-OK | dromaeo_css | took 1111783ms 12:59:04 INFO - TEST-START | kraken 12:59:04 INFO - operating with platform_type : linux_ 12:59:04 INFO - Initialising browser for kraken test... 12:59:04 INFO - TEST-INFO | started process 22933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6PPi5h/profile http://localhost:55620/getInfo.html) 12:59:08 INFO - PROCESS | 22933 | __metrics Screen width/height:1600/1200 12:59:08 INFO - PROCESS | 22933 | colorDepth:24 12:59:08 INFO - PROCESS | 22933 | Browser inner width/height: 1024/697 12:59:08 INFO - PROCESS | 22933 | __metrics 12:59:09 ERROR - PROCESS | 22933 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:59:09 INFO - PROCESS | 22933 | console.error: PushService: 12:59:09 INFO - PROCESS | 22933 | stateChangeProcessEnqueue: Error transitioning state 12:59:09 INFO - PROCESS | 22933 | UnknownError 12:59:10 INFO - TEST-INFO | 22933: exit 0 12:59:10 INFO - Browser initialized. 12:59:10 INFO - Running cycle 1/1 for kraken test... 12:59:10 INFO - TEST-INFO | started process 23024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6PPi5h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:22 INFO - PROCESS | 23024 | RSS: Main: 145354752 12:59:22 INFO - PROCESS | 23024 | 12:59:24 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55620/tests/kraken/driver.html?testName=audio-beat-detection) 12:59:25 INFO - PROCESS | 23024 | RSS: Main: 195207168 12:59:25 INFO - PROCESS | 23024 | 12:59:28 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55620/tests/kraken/driver.html?testName=audio-dft) 12:59:28 INFO - PROCESS | 23024 | RSS: Main: 192622592 12:59:28 INFO - PROCESS | 23024 | 12:59:31 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55620/tests/kraken/driver.html?testName=audio-fft) 12:59:32 INFO - PROCESS | 23024 | RSS: Main: 278962176 12:59:32 INFO - PROCESS | 23024 | 12:59:34 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55620/tests/kraken/driver.html?testName=audio-oscillator) 12:59:34 INFO - PROCESS | 23024 | RSS: Main: 187641856 12:59:34 INFO - PROCESS | 23024 | 12:59:36 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:37 INFO - PROCESS | 23024 | RSS: Main: 188518400 12:59:37 INFO - PROCESS | 23024 | 12:59:40 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55620/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:40 INFO - PROCESS | 23024 | RSS: Main: 223027200 12:59:41 INFO - PROCESS | 23024 | 12:59:44 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55620/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:44 INFO - PROCESS | 23024 | RSS: Main: 223633408 12:59:44 INFO - PROCESS | 23024 | 12:59:47 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55620/tests/kraken/driver.html?testName=json-parse-financial) 12:59:48 INFO - PROCESS | 23024 | RSS: Main: 223285248 12:59:48 INFO - PROCESS | 23024 | 12:59:49 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:50 INFO - PROCESS | 23024 | RSS: Main: 201314304 12:59:50 INFO - PROCESS | 23024 | 12:59:52 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:52 INFO - PROCESS | 23024 | RSS: Main: 202080256 12:59:52 INFO - PROCESS | 23024 | 12:59:54 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:55 INFO - PROCESS | 23024 | RSS: Main: 208801792 12:59:55 INFO - PROCESS | 23024 | 12:59:57 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:59:58 INFO - PROCESS | 23024 | RSS: Main: 214753280 12:59:58 INFO - PROCESS | 23024 | 13:00:01 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:00:01 INFO - PROCESS | 23024 | RSS: Main: 215330816 13:00:01 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | Cycle 1(1): loaded http://localhost:55620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55620/tests/kraken/driver.html?testName=ai-astar) 13:00:03 INFO - PROCESS | 23024 | RSS: Main: 257081344 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | __start_tp_report 13:00:03 INFO - PROCESS | 23024 | _x_x_mozilla_page_load 13:00:03 INFO - PROCESS | 23024 | _x_x_mozilla_page_load_details 13:00:03 INFO - PROCESS | 23024 | |i|pagename|runs| 13:00:03 INFO - PROCESS | 23024 | |0;ai-astar;110;103;109;109;109;110;109;110;109;110 13:00:03 INFO - PROCESS | 23024 | |1;audio-beat-detection;157;124;129;188;125;125;151;123;155;123 13:00:03 INFO - PROCESS | 23024 | |2;audio-dft;162;161;161;162;160;161;160;163;161;161 13:00:03 INFO - PROCESS | 23024 | |3;audio-fft;75;75;74;119;75;75;75;74;111;76 13:00:03 INFO - PROCESS | 23024 | |4;audio-oscillator;85;85;113;84;84;84;111;83;84;128 13:00:03 INFO - PROCESS | 23024 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;117;116;116 13:00:03 INFO - PROCESS | 23024 | |6;imaging-darkroom;145;145;146;146;147;146;146;146;145;146 13:00:03 INFO - PROCESS | 23024 | |7;imaging-desaturate;95;95;94;95;96;95;96;95;96;95 13:00:03 INFO - PROCESS | 23024 | |8;json-parse-financial;52;49;50;51;50;51;52;50;50;51 13:00:03 INFO - PROCESS | 23024 | |9;json-stringify-tinderbox;60;60;59;59;59;59;58;60;59;58 13:00:03 INFO - PROCESS | 23024 | |10;stanford-crypto-aes;77;76;76;76;82;78;78;77;112;79 13:00:03 INFO - PROCESS | 23024 | |11;stanford-crypto-ccm;122;132;115;117;115;123;117;117;119;138 13:00:03 INFO - PROCESS | 23024 | |12;stanford-crypto-pbkdf2;157;154;151;155;154;153;154;152;155;156 13:00:03 INFO - PROCESS | 23024 | |13;stanford-crypto-sha256-iterative;70;60;61;60;61;61;62;60;65;62 13:00:03 INFO - PROCESS | 23024 | __end_tp_report 13:00:03 INFO - PROCESS | 23024 | __start_cc_report 13:00:03 INFO - PROCESS | 23024 | _x_x_mozilla_cycle_collect,1573 13:00:03 INFO - PROCESS | 23024 | __end_cc_report 13:00:03 INFO - PROCESS | 23024 | __startTimestamp1466625603613__endTimestamp 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | ------- Summary: start ------- 13:00:03 INFO - PROCESS | 23024 | Number of tests: 14 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.50 stddev:2.10 (1.9%) stddev-sans-first:2.18 13:00:03 INFO - PROCESS | 23024 | Values: 110.0 103.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:140.00 stddev:21.97 (15.7%) stddev-sans-first:22.42 13:00:03 INFO - PROCESS | 23024 | Values: 157.0 124.0 129.0 188.0 125.0 125.0 151.0 123.0 155.0 123.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 13:00:03 INFO - PROCESS | 23024 | Values: 162.0 161.0 161.0 162.0 160.0 161.0 160.0 163.0 161.0 161.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:17.03 (22.7%) stddev-sans-first:17.82 13:00:03 INFO - PROCESS | 23024 | Values: 75.0 75.0 74.0 119.0 75.0 75.0 75.0 74.0 111.0 76.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.00 stddev:16.63 (19.8%) stddev-sans-first:17.31 13:00:03 INFO - PROCESS | 23024 | Values: 85.0 85.0 113.0 84.0 84.0 84.0 111.0 83.0 84.0 128.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 13:00:03 INFO - PROCESS | 23024 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 13:00:03 INFO - PROCESS | 23024 | Values: 145.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:00:03 INFO - PROCESS | 23024 | Values: 95.0 95.0 94.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.97 (1.9%) stddev-sans-first:0.88 13:00:03 INFO - PROCESS | 23024 | Values: 52.0 49.0 50.0 51.0 50.0 51.0 52.0 50.0 50.0 51.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 13:00:03 INFO - PROCESS | 23024 | Values: 60.0 60.0 59.0 59.0 59.0 59.0 58.0 60.0 59.0 58.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:77.50 stddev:11.01 (14.2%) stddev-sans-first:11.58 13:00:03 INFO - PROCESS | 23024 | Values: 77.0 76.0 76.0 76.0 82.0 78.0 78.0 77.0 112.0 79.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:120.50 stddev:7.72 (6.4%) stddev-sans-first:8.19 13:00:03 INFO - PROCESS | 23024 | Values: 122.0 132.0 115.0 117.0 115.0 123.0 117.0 117.0 119.0 138.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.10 Median:154.50 stddev:1.79 (1.2%) stddev-sans-first:1.56 13:00:03 INFO - PROCESS | 23024 | Values: 157.0 154.0 151.0 155.0 154.0 153.0 154.0 152.0 155.0 156.0 13:00:03 INFO - PROCESS | 23024 | 13:00:03 INFO - PROCESS | 23024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:61.50 stddev:3.12 (5.1%) stddev-sans-first:1.58 13:00:03 INFO - PROCESS | 23024 | Values: 70.0 60.0 61.0 60.0 61.0 61.0 62.0 60.0 65.0 62.0 13:00:03 INFO - PROCESS | 23024 | -------- Summary: end -------- 13:00:03 INFO - PROCESS | 23024 | 13:00:04 INFO - TEST-INFO | 23024: exit 0 13:00:04 INFO - TEST-OK | kraken | took 59509ms 13:00:04 INFO - SUITE-END | took 1171s 13:00:04 INFO - Completed test suite (00:19:31) 13:00:04 INFO - javascript benchmark 13:00:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.1431634933087, 3374.3588718143565, 3399.0312760863158, 3415.265717870657, 3415.84628691709, 5605.607607467474, 5641.323041235052, 5708.800191993281, 5712.200291959129, 5725.055365864632, 5613.270274864272, 5676.716164191795, 5686.63036902601, 5693.743781529831, 5697.658140511572, 4893.975530122344, 4979.278004689318, 5131.025105230013, 5136.152534831757, 5170.09523333417, 5085.262636917645, 5112.514311140454, 5112.8977420451565, 5164.922526162091, 5242.842714718565, 5125.538701516863, 5128.205128205134, 5152.175651895697, 5231.607629427808, 5236.345456817898, 5164.070467315882, 5234.8691282717855, 5236.214567814839, 5238.5809135269465, 5258.658187217857, 4997.750112494361, 5007.173816320303, 5015.22264049073, 5042.016806722654, 5123.641345105844, 5564.638298510584, 5584.553235741171, 5590.049691552445, 5593.300837395325, 5622.353429355595, 6041.335453100155, 6054.8183554493435, 6065.400843881873, 6070.41320832688, 6093.329733729286, 5927.970360148215, 6030.366811484775, 6052.788152414689, 6093.573449858512, 6140.34210763096, 5778.6243894147165, 5779.826605201851, 5779.913301300484, 5791.362950075489, 5792.333881603628, 5905.173275741399, 6258.530610204253, 6262.3111457739615, 6268.373162683695, 6269.404406581368, 5851.941480585139, 5915.704214789243, 5919.55603329752, 5956.9873121569435, 6001.219841420588, 6048.304444988883, 6085.148079268906, 6090.20827292458, 6093.268807743099, 6099.84750381244, 5822.039363505059, 6008.6394816310285, 6011.699415029231, 6021.668808215591, 6024.427679370453, 5878.353381128072, 5932.703364831741, 5943.970280148572, 5993.910091348634, 6000.819975400745, 4582.1293954148605, 4583.885402864955, 4587.220172570671, 4588.082383523242, 4607.285870690049, 4077.857274995361, 4097.959020409818, 4110.547839737626, 4110.958890411118, 4128.298189307825, 5768.682722450221, 5771.336296325976, 5786.623869448473, 5840.182374467578, 5903.468687818117, 6175.197224360894, 6180.5673602848265, 6183.041628547582, 6184.938150618526, 6186.845328866814, 5662.462066103713, 5703.287089113861, 5861.17943487912, 5880.7353669085, 5887.587868849139, 5175.4824517548695, 5226.425093239741, 5229.111051121318, 5232.0, 5249.0, 6284.968575157095, 6287.811365659038, 6291.465225455796, 6291.465225455888, 6295.748170073238, 5903.881922361443, 5929.288485381781, 5949.405059494016, 6003.909941350796, 6046.879062418815, 6217.782377616762, 6229.750809967732, 6234.9688251558455, 6236.594621349598, 6241.656708880873, 5853.64878107315, 5884.529237661062, 5896.262967129109, 5905.202797622438, 5933.317668468008, 5990.7004649768205, 6002.849928751816, 6059.909101363572, 6099.66451845135, 6117.188044311343, 5931.1992880960515, 5949.196858424058, 5967.731452084753, 5970.671613061323, 5979.342272350125, 5841.94158058414, 5892.734826932884, 5895.0, 5898.469137777621, 5955.0, 5638.915416268677, 5720.313562372542, 5751.539876809761, 5773.97113014449, 5834.708264586839, 5924.7037648118285, 5933.169356290036, 5952.642841429528, 5958.314793798769, 5958.34458209588, 5575.2473416088305, 5744.454276843693, 5785.450382213683, 5803.912941305968, 5808.680522571299], "value": 5578.396556135639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.1774031667724, 648.2674577727167, 656.2158220925992, 669.8559809640926, 672.7645324136556, 33305.66694333056, 36350.454743178874, 36389.63610363896, 36419.45370819436, 36499.452508212366, 36504.81747591265, 37202.813985930035, 46270.76864615681, 47697.52302476974, 47943.520564794344, 8801.119888011195, 9006.774830629254, 9019.95490022549, 9020.052894446088, 9025.864612030824, 8824.249938755214, 8900.910990890105, 8909.95545022274, 8916.15296546827, 8916.598753056096, 8466.66133354665, 8651.740447786577, 8653.826923461527, 10888.40113793741, 11149.609763658274, 11036.392998385085, 11090.445477726162, 11098.167637427225, 11103.44482775862, 11109.72225694356, 10826.296290741077, 10863.945680271549, 10893.237473376867, 10900.672979810619, 10902.672919812418, 38084.0, 42837.143257134994, 43475.56524434747, 43509.56490435087, 47690.76154619239, 3591.5331006969186, 3614.710823134143, 3630.3465376232266, 3902.570717221103, 4073.124278280184, 34383.31233375319, 34593.6540634593, 34615.307693845985, 34711.479327810106, 35022.47466288008, 4283.97858010711, 4330.913381732379, 4353.020570371673, 4394.6923715339935, 4496.033352829125, 365339.0, 365691.0, 365946.9999999973, 366257.0, 366978.0, 65823.0, 65872.67063664651, 66143.0, 66285.0, 66603.66698166575, 61604.38395616076, 61731.691341543, 61820.0, 61978.0, 62002.0, 17069.231884564975, 17487.475375738748, 17495.562610934572, 17498.650026999643, 17505.474835754947, 14444.422223111169, 14580.125192488485, 14587.854121458862, 14587.927060364631, 14589.0, 17398.130093495274, 19469.51326216856, 19527.511812204808, 19555.608887822164, 19608.90195549013, 5873.148393482921, 6210.9068363974575, 6295.527835412271, 6367.968160159262, 6396.680165991775, 1081.6484642491064, 1148.534843388429, 1191.267370567095, 1222.6148763139583, 1271.313490715022, 33587.83206083954, 34482.82758586241, 35062.29875402478, 35207.4718879217, 35308.82345588256, 1164.342146687136, 1187.9703007424885, 1190.2323001663879, 1238.4674589926237, 1337.8996575256895, 17705.0, 18421.355252566096, 18436.354727584738, 18449.81550184481, 18636.0, 569511.0, 572937.0, 575902.0, 576272.0, 576350.0, 64341.35658643447, 64735.67632161809, 64851.67574162099, 65026.34973650203, 65141.0, 1372.773492373767, 1419.176877411099, 1419.5670320552124, 1455.2505459688268, 1461.043016823982, 32334.676653234106, 33262.33475330431, 33521.16197095092, 33908.0, 34077.48883766795, 56979.43020569741, 57193.142102867656, 57311.42688573061, 57338.0, 57370.426295736506, 475933.0, 477990.0, 479210.0, 479443.0, 479961.0, 45992.7700361496, 47392.763036184595, 48708.75645621891, 48731.02537949292, 48755.75622121867, 53296.0, 53561.46438535565, 53598.46401535935, 54462.0, 54869.45130548803, 44913.77543112264, 45091.0, 45185.32222016607, 45281.32078018898, 46188.7690561545, 44032.559674402844, 44433.45521388992, 44678.553214467436, 45071.549284506735, 45443.318350224115, 44584.885377865816, 45005.54994450013, 45291.320630191236, 45645.31532026956, 45827.31259031184, 36911.261774763814, 39001.804990974866, 39802.60197398105, 40077.799611001756, 40318.0, 29325.56011659784, 29640.258993525335, 29947.401051978402, 30151.849240753654, 30162.849185754807], "value": 21695.366132464096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.37976895350124, 412.6059613069519, 424.6878544269961, 425.40230975479454, 437.6476936066467, 15466.845331546681, 19729.408117756455, 20244.59510809785, 20249.58252922296, 20936.790632093675, 19781.703274450858, 19822.108005139766, 19854.801451985477, 20010.799892001076, 20095.497612559655, 5555.722213889309, 5794.6523208607405, 5808.12878068289, 5936.050231962887, 5938.940610593882, 5813.854653633672, 5886.0, 5890.911636325459, 5912.408759124096, 5913.586048976574, 5654.0, 5861.0915308127305, 5874.530037596982, 5877.2947246330505, 5883.558733095014, 5714.0, 5774.913376299359, 5822.0, 5823.5341172706085, 5845.532357411418, 5810.82567522975, 5861.648301101947, 5886.676232807194, 5887.234659494281, 5892.263467066617, 14677.192754398504, 18448.354307599304, 23472.64791028119, 24278.635820462707, 24316.63525047108, 2056.845736569748, 2063.0716177719937, 2089.3836318286144, 2172.652375619909, 2351.3886389538843, 10604.416757078357, 10722.785544289149, 10985.340879547173, 11312.264702794291, 14294.64263393413, 1993.5514509235306, 2091.9477013074793, 2093.926712565053, 2127.6914847347048, 2168.8698678079368, 53872.965348326215, 54593.635159120946, 56140.43859561393, 56358.0, 78509.60745196295, 11568.652940411801, 11605.129615278887, 11745.765084698258, 11764.529418823151, 11775.882241177478, 16250.674986500204, 16251.59371015734, 16312.67374652524, 16334.918325408296, 16371.263293151836, 8638.481691098554, 8841.513716745641, 8896.957792030631, 8897.688580899767, 8915.910840891638, 8489.235968762841, 8527.147285271423, 8611.655533778703, 8641.179087986631, 8654.048054713976, 4699.224627936421, 4763.904721905612, 4784.282357646381, 4922.1787938462285, 4957.157283261854, 1836.1800274280015, 1857.1178690122083, 1877.9718304225448, 1887.8678492505667, 1902.4958386027713, 979.2019504104132, 997.3915911294105, 1049.1397054415306, 1066.9679909602723, 1147.1969621265148, 19550.608987820164, 19676.40970770879, 19793.604127917362, 19955.900220498803, 20138.69791953122, 994.7065615643403, 994.9850752238722, 1031.2781053262745, 1032.3702541449709, 1036.896310368972, 10858.2399232053, 11103.222774405715, 11149.498272577754, 11166.832497512543, 11167.329960202414, 502131.0, 509255.0, 515254.0, 516257.0, 531332.0, 98738.50630746943, 98889.50555247178, 100752.49623751834, 102075.48962255141, 102672.48663756634, 1001.6494227020485, 1008.2186305613062, 1012.4431562640518, 1030.07808011829, 1052.1319911073394, 17460.0, 17495.82504174942, 17670.20484078245, 17778.0, 18193.818061819213, 41636.79181604073, 41896.581034189265, 42730.78634606807, 43746.34380484232, 43814.34278485889, 59873.70063149656, 60649.69675151596, 61108.69445652743, 61201.0, 62038.37961620326, 8926.553672316488, 9267.212286955684, 9400.247980161434, 9426.528673566432, 9547.618095276111, 12268.631941041784, 13488.5279015234, 13643.181409115485, 13746.862531374958, 14057.578272651837, 11811.645650630495, 11969.64091077269, 12153.149279550347, 12386.62840114798, 12458.688532786753, 8277.875831862406, 11799.646010619696, 11894.881051189377, 12163.695907602381, 12308.938455307667, 11911.82132268034, 12121.333326667118, 12298.569550065704, 12489.875101249234, 12496.125271230927, 7748.728794492165, 9088.0, 9171.77070573241, 9210.95394523023, 9267.582958766738, 10508.737281568023, 11812.169113787377, 11883.405829708652, 12080.154389192672, 12216.205946613441], "value": 9425.925282713026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.9632259193513, 1586.7540531217662, 1616.046532545798, 1795.2011354947047, 1908.5514903997557, 9341.673041443551, 9743.025697430254, 9782.364146330492, 10036.397816131037, 10048.547815348309, 9680.080392362732, 9892.703218903445, 9894.307398482091, 9907.851382229272, 9909.504524773769, 2179.259051922346, 2514.4091138582417, 2556.2203527923975, 2580.213035024317, 2586.6378706980945, 2537.086648806428, 2549.566573682469, 2553.74462553745, 2559.8720063996725, 2559.8848051837617, 2505.8245922785413, 2529.911453099142, 2533.3160046787357, 2535.2140836340795, 2536.4927014597156, 2152.7847215278503, 2499.2252401755422, 2578.8065895057944, 2583.522048421048, 2595.8182927195103, 2465.161844972718, 2514.1828905605566, 2515.396304886814, 2554.1443616388533, 2555.795536357087, 9838.950805245999, 9883.703488895344, 9897.4556399398, 9903.45530995795, 9910.25673074515, 5813.738381772788, 5944.7027648617395, 5954.851128721773, 5954.8809023819285, 5955.493783028448, 3668.284684486526, 3760.1351689111384, 3769.3026790043928, 3784.2053168834577, 3826.1773718650625, 1163.7209256103106, 1176.9588064417703, 1209.3711270139565, 1219.3171823778712, 1233.734747029384, 14008.719825603534, 14130.92934535331, 14157.504487342894, 14173.929130354281, 14201.431942722278, 5254.369475662945, 5304.761285742151, 5358.035553600389, 5388.245645609618, 5403.540699040625, 11677.240979336486, 11685.649430517098, 11692.532298708127, 11752.0, 11806.40967951599, 5317.361916570037, 5970.761169553256, 6046.486048685823, 6054.697265136726, 6057.636541807506, 5375.220593013991, 5511.669299842022, 5517.200005999108, 5530.142827861688, 5533.667979921218, 4477.8208871644765, 4505.887352816206, 4535.886602834956, 4580.427446569179, 4589.678722489393, 1427.557457188275, 1442.1058943455125, 1465.0550394995169, 1470.8308544517304, 1470.9705805884037, 936.3539157980971, 962.2542529539522, 1095.2606990281529, 1106.551846502168, 1108.3903852880883, 6395.808125756234, 6567.408933196035, 6575.079488871562, 6575.934240657532, 6609.0, 1019.4647809899861, 1038.6364772329775, 1040.6802300660868, 1065.4566171252718, 1090.6237348114887, 4533.365328853963, 4641.396618439581, 4716.457607375196, 4725.385699858996, 4755.025219829927, 12210.206336588093, 12920.095593308566, 12930.935345323212, 12977.935110324388, 13016.219026858229, 12549.498020079278, 12765.808512872314, 12772.425240864184, 12892.548760793326, 12914.612561623166, 8843.292536597186, 8846.557672116369, 8908.8663670045, 8970.372073954892, 8989.595468203946, 6649.0691303218555, 6654.83362915931, 6675.132232809704, 6689.397954184147, 6766.15423072116, 11323.943380283046, 11382.373969431761, 11632.709182270512, 11656.0, 11659.76680466369, 11699.986047716999, 11841.28952262867, 11870.821937671115, 12043.638690839289, 12046.277223366276, 7492.0, 7656.196099409482, 7661.387089032975, 8285.4200205985, 8435.493870367798, 9030.729078127666, 9310.72067837966, 9465.716028519155, 9530.809383812424, 9793.902060979299, 8517.403781735218, 8567.100454452442, 8586.742397727829, 8620.78448038804, 8683.435576687496, 8507.319414446705, 8534.061253262013, 8731.694390696295, 8733.56332183401, 8873.778155545904, 7728.652210650646, 7762.961185194264, 7825.765227043198, 7838.843223135391, 7843.7254696085365, 5755.8561035974435, 5904.704764761659, 5916.142159386951, 5970.164177015308, 6104.053871649901, 5630.127330263816, 5634.126710359901, 5655.4910058094965, 5732.254806875247, 5864.67744274052], "value": 5184.017614034477, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.74316235472816, 369.88903329001295, 373.19576313045394, 374.69462388153636, 382.22980693901775, 5602.32772067352, 5608.523275521576, 5650.576206784493, 5653.349864765548, 5660.150977353399, 5258.658187217838, 5290.042684206839, 5443.0, 5472.480114389136, 5549.250851135095, 4317.15815415994, 4336.349547567858, 4342.218400687875, 4346.413234213388, 4365.017870979036, 4372.256716358211, 4396.934045989313, 4409.096135292273, 4438.134563760052, 4446.1107778444275, 4039.798010099498, 4198.559151289117, 4330.39374487572, 4359.2371335016405, 4372.475302963649, 4299.50555686097, 4322.82708691652, 4335.978320108379, 4357.237483440401, 4363.170997510495, 3893.260280546687, 3898.3567711327596, 3903.3754599264266, 3911.7457365271453, 3911.7848518331766, 5127.230915362688, 5228.529432351107, 5230.535450073985, 5317.574594032468, 5319.739110877861, 4888.9755551222015, 4948.554630083274, 4984.900301993976, 5019.84940451787, 5027.723475208862, 5718.284514645589, 5723.6246957512585, 5727.255456790632, 5751.712414379264, 5752.424757524256, 3959.940600890989, 4191.7484950903045, 4198.3702444633545, 4199.91600167998, 4240.279152544044, 5931.199288096138, 5951.226340575698, 5958.612690175125, 5978.701064946778, 6004.159417681484, 4334.349847522833, 4340.218760623118, 4347.261095561737, 4349.869503914888, 4351.998080882766, 4228.1966426378885, 4323.4379530661445, 4329.480462344476, 4349.586789255016, 4383.539728328544, 4892.2661600760175, 4908.288298196741, 4919.557239848359, 4941.851744447672, 4948.1835497142565, 5737.160105747682, 5784.537237021028, 5785.88428231433, 5813.854653633608, 5829.134676903435, 1420.6803469219342, 1432.649000994763, 1452.8038714773581, 1462.8464011278875, 1509.3736099518576, 959.8320293948531, 965.3098034905076, 969.4377261188635, 988.7429268390271, 995.6117114325419, 4995.275685025724, 5042.512458824655, 5089.745512724349, 5106.727506259753, 5123.7438128093445, 5258.553022993012, 5263.078961181778, 5293.338332708411, 5297.231901374356, 5306.442823503477, 4849.563539281411, 5040.84877453677, 5056.811649262494, 5083.339165908408, 5106.599898047912, 2814.620026296465, 2822.5201715707967, 2827.4062446885973, 2828.78784091194, 2835.631367922157, 5404.756785944642, 5456.699881506476, 5462.945370546323, 5481.808136715196, 5499.7250137492965, 5125.308083408692, 5366.316841579211, 5366.6243362965, 5372.0, 5372.838814835562, 5365.463453654604, 5433.864153396196, 5448.346198456211, 5450.645708028966, 5471.945280547223, 5246.160614301693, 5247.8163264287095, 5265.921011184759, 5277.868053298698, 5327.588189129961, 4925.187344088328, 5087.2957559218075, 5122.8975420492125, 5170.759017835617, 5224.9738751306, 5264.736763161904, 5349.0, 5384.6769193848495, 5422.918656220081, 5464.316960379952, 3909.0454772613693, 3918.941215881707, 3932.9213415732097, 3958.6437220650278, 3959.8812035638975, 4960.851174464772, 5254.106801843619, 5270.657407268515, 5271.894562108813, 5721.082248053606, 5680.693440508623, 5809.157672137601, 5810.0, 5819.098039803837, 5823.4467725566, 5694.772209111589, 5769.307683078057, 5774.307083150049, 5791.276090488689, 5805.419458054161, 5485.561155107502, 5706.8573285666525, 5762.567807414377, 5769.30764310833, 5785.681787501728, 5795.565332599987, 5801.82594522165, 5808.215890854681, 5822.796202132905, 5846.093855452412, 5497.972510137583, 5683.77264909399, 5705.600607957569, 5745.9425405745405, 5750.878578677118], "value": 4272.109284552336, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.541309616009, 733.5305404541094, 745.2547452547452, 796.2037962037964, 822.2681813186265, 14950.177740224284, 15266.618334541641, 15472.458463953764, 15547.37810487582, 15549.922250388747, 15286.388544458236, 15543.22283885804, 15566.143862087582, 15574.221288935565, 15577.221138943065, 717.2970488920861, 825.1583384947351, 854.2738672128703, 860.3418384935529, 869.76516340588, 859.8538248497771, 864.5979619476942, 865.2558799432483, 867.2628265973934, 867.7526904832124, 758.7192738686693, 928.4754113925644, 929.1544694328163, 929.604917909889, 929.869818225449, 893.7676204186894, 908.7001289574457, 909.9408538445012, 922.0917396364575, 922.7139586728135, 671.1509939925998, 675.8986152077179, 675.9155105611799, 676.2696288008988, 676.4216594811414, 13083.149595276276, 13101.410436530283, 13154.868451315555, 13224.471021159143, 13228.0, 14970.326335314938, 15156.24218789056, 15234.390624375012, 15280.0, 15482.690346193012, 12212.511499540007, 12260.81608775869, 12361.0, 13533.932330338384, 14201.218932958684, 4862.319275301461, 4899.0, 4927.926081108786, 4935.284383764334, 5043.5965122790085, 77122.6143869277, 77662.6116869412, 77678.61160694217, 78178.0, 78360.60819695922, 11761.941190293994, 11861.525538978516, 11914.523419063315, 11960.700982475508, 12088.09339299556, 20791.168353266003, 20967.685484717742, 21022.684659730116, 21035.8948205258, 21040.789592103883, 8936.374453788303, 9007.81984360309, 9013.324000699973, 9015.413998090235, 9083.0, 4815.951840481621, 5057.519535644108, 5080.933004069113, 5145.202493613496, 5293.232481290268, 3599.7480176387926, 3685.5761587417255, 3687.852485900534, 3693.9445908311395, 3700.40793473043, 667.7095463473405, 669.6049330894796, 676.4284179868004, 683.9452843772486, 693.5214701855704, 667.9365460281266, 703.5426972467936, 706.1314583062862, 713.0, 715.6529083394549, 10125.291229614004, 10232.948835255926, 10257.794844103077, 10329.431881246604, 10338.0, 734.9559026458429, 745.9780101261307, 746.7138624296499, 750.0, 762.0969151555424, 4444.444444444444, 4693.0, 4714.38712967312, 4782.3897991635195, 4858.421013170733, 96349.0, 99593.0, 101077.0, 115427.0, 118269.0, 99605.0, 100425.0, 100901.49549252207, 102443.0, 102605.0, 88572.0, 94388.0, 94728.0, 95852.0, 95984.52007739917, 9818.852717209105, 9881.950590247003, 9972.152367048882, 9999.503401698308, 10037.799244015225, 51156.0, 52465.213021805466, 52559.21161182662, 52921.0, 53840.461595383546, 69208.70961168675, 77178.2282177171, 79056.20943790488, 79757.0, 80138.0, 13226.272555009182, 13375.933120334725, 13414.463421463031, 13690.178589284675, 13794.37925293344, 12539.74920501603, 14426.278686065445, 15894.364225430852, 15982.760258596363, 16279.51161465158, 14385.784213237019, 14506.637334066732, 14705.0, 14721.852781472047, 14899.62750931192, 14557.563273101823, 14912.403503859725, 14978.0, 15053.774193387328, 15332.386704531693, 13859.445622175, 14304.070235434663, 14304.57086287413, 14880.479183228535, 15359.692806144038, 12182.147249692436, 12529.93735031319, 12775.0, 12916.93541532324, 13212.273324966834, 12209.267443953391, 12365.196262242926, 12441.986965157334, 12456.31490268044, 12565.371731413576], "value": 7905.799387066504, "unit": "score"}], "name": "dromaeo_css", "value": 7645.685151115308, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 129.0, 188.0, 125.0, 125.0, 151.0, 123.0, 155.0, 123.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 160.0, 161.0, 160.0, 163.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 119.0, 75.0, 75.0, 75.0, 74.0, 111.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 113.0, 84.0, 84.0, 84.0, 111.0, 83.0, 84.0, 128.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 50.0, 51.0, 50.0, 51.0, 52.0, 50.0, 50.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 58.0, 60.0, 59.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 76.0, 82.0, 78.0, 78.0, 77.0, 112.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 132.0, 115.0, 117.0, 115.0, 123.0, 117.0, 117.0, 119.0, 138.0], "value": 121.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 151.0, 155.0, 154.0, 153.0, 154.0, 152.0, 155.0, 156.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 60.0, 61.0, 60.0, 61.0, 61.0, 62.0, 60.0, 65.0, 62.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1473.1, "alertThreshold": 2.0}]} 13:00:04 INFO - Return code: 0 13:00:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:00:04 ERROR - # TBPL SUCCESS # 13:00:04 INFO - Running post-action listener: _resource_record_post_action 13:00:04 INFO - ##### 13:00:04 INFO - ##### Finished run-tests step (success) 13:00:04 INFO - ##### 13:00:04 INFO - Running post-run listener: _resource_record_post_run 13:00:05 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 508243968; Read time: 36; Write time: 440080 13:00:05 INFO - TinderboxPrint: CPU usage
13.2% 13:00:05 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 13:00:05 INFO - TinderboxPrint: I/O write bytes / time
508,243,968 / 440,080 13:00:05 INFO - TinderboxPrint: CPU idle
8,240.0 (86.8%) 13:00:05 INFO - TinderboxPrint: CPU user
1,204.5 (12.7%) 13:00:05 INFO - TinderboxPrint: Swap in / out
0 / 0 13:00:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252473344; Read time: 0; Write time: 279980 13:00:05 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 255041536; Read time: 36; Write time: 160076 13:00:05 INFO - Running post-run listener: _upload_blobber_files 13:00:05 INFO - Blob upload gear active. 13:00:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:00:05 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 13:00:05 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:00:05 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:00:06 INFO - (blobuploader) - INFO - Open directory for files ... 13:00:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:00:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:00:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:07 INFO - (blobuploader) - INFO - Done attempting. 13:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:09 INFO - (blobuploader) - INFO - Done attempting. 13:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:00:14 INFO - (blobuploader) - INFO - Done attempting. 13:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:00:14 INFO - Return code: 0 13:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:00:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdd0857d89e5a61918e38163bc5f4297884b6c762859281d0265f0688dde865a7b990a0c2b0e0531f48b3ebef686128ab4783d92831912c4e28fad19179f9f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e953a05c1d26003036c1f093d80068871db9e4d2f4cbf3547649cf8958dc1bb606caba5958ca282a86791ad9bb4b115e852ed97813912420f0f7094125d820a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ece103f265baf868c80b0b8e59bf356cb8bb0ead28ee60e0ae9a10c6b169f3151aa914471a682f1f214ba8aa27000c086fb72ce40fc3279cbf6ce6ccdf35ddf"} 13:00:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:00:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:00:14 INFO - Contents: 13:00:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdd0857d89e5a61918e38163bc5f4297884b6c762859281d0265f0688dde865a7b990a0c2b0e0531f48b3ebef686128ab4783d92831912c4e28fad19179f9f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e953a05c1d26003036c1f093d80068871db9e4d2f4cbf3547649cf8958dc1bb606caba5958ca282a86791ad9bb4b115e852ed97813912420f0f7094125d820a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ece103f265baf868c80b0b8e59bf356cb8bb0ead28ee60e0ae9a10c6b169f3151aa914471a682f1f214ba8aa27000c086fb72ce40fc3279cbf6ce6ccdf35ddf"} 13:00:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:00:14 INFO - Copying logs to upload dir... 13:00:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:00:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.318541 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-22 13:00:13.901646) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:13.907571) ========= 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=0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdd0857d89e5a61918e38163bc5f4297884b6c762859281d0265f0688dde865a7b990a0c2b0e0531f48b3ebef686128ab4783d92831912c4e28fad19179f9f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e953a05c1d26003036c1f093d80068871db9e4d2f4cbf3547649cf8958dc1bb606caba5958ca282a86791ad9bb4b115e852ed97813912420f0f7094125d820a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ece103f265baf868c80b0b8e59bf356cb8bb0ead28ee60e0ae9a10c6b169f3151aa914471a682f1f214ba8aa27000c086fb72ce40fc3279cbf6ce6ccdf35ddf"} build_url:https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/Oy_yeA7wSoiaPcT779fLdw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdd0857d89e5a61918e38163bc5f4297884b6c762859281d0265f0688dde865a7b990a0c2b0e0531f48b3ebef686128ab4783d92831912c4e28fad19179f9f9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e953a05c1d26003036c1f093d80068871db9e4d2f4cbf3547649cf8958dc1bb606caba5958ca282a86791ad9bb4b115e852ed97813912420f0f7094125d820a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ece103f265baf868c80b0b8e59bf356cb8bb0ead28ee60e0ae9a10c6b169f3151aa914471a682f1f214ba8aa27000c086fb72ce40fc3279cbf6ce6ccdf35ddf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:13.933059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:13.933382) ========= 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=0333a256a5e4f052382dd180000001b1-1466622943.952787-410928065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 13:00:14.020128) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:00:14.020532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 13:00:14.020979) ========= ========= Total master_lag: 0.19 =========