builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1460722048.55 results: success (0) buildid: 20160415023022 builduid: 609f883fb5e14518841e3b8e27c3afb5 revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.551219) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.552150) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.552764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.571869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.572562) ========= 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=d2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 05:07:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|: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.8M=0s 2016-04-15 05:07:28 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.700903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.701606) ========= 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=d2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016370 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.754436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:28.755240) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 529cff9c5663a3581dfb5e690727144f07e8e23c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 529cff9c5663a3581dfb5e690727144f07e8e23c --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=d2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 05:07:29,020 truncating revision to first 12 chars 2016-04-15 05:07:29,020 Setting DEBUG logging. 2016-04-15 05:07:29,020 attempt 1/10 2016-04-15 05:07:29,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/529cff9c5663?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 05:07:29,657 unpacking tar archive at: fx-team-529cff9c5663/testing/mozharness/ program finished with exit code 0 elapsedTime=0.905957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:29.679184) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:29.679953) ========= script_repo_revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:29.681017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:29.681684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 05:07:29.755287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 47 secs) (at 2016-04-15 05:07:29.756035) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:30 INFO - MultiFileLogger online at 20160415 05:07:30 in /builds/slave/test 05:07:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:30 INFO - {'append_to_log': False, 05:07:30 INFO - 'base_work_dir': '/builds/slave/test', 05:07:30 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:30 INFO - 'branch': 'Fx-Team', 05:07:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:30 INFO - 'config_files': ('talos/linux_config.py',), 05:07:30 INFO - 'default_actions': ('clobber', 05:07:30 INFO - 'read-buildbot-config', 05:07:30 INFO - 'download-and-extract', 05:07:30 INFO - 'populate-webroot', 05:07:30 INFO - 'create-virtualenv', 05:07:30 INFO - 'install', 05:07:30 INFO - 'run-tests'), 05:07:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:30 INFO - 'download_minidump_stackwalk': True, 05:07:30 INFO - 'download_symbols': 'ondemand', 05:07:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:30 INFO - 'installer_path': 'installer.exe', 05:07:30 INFO - 'log_level': 'info', 05:07:30 INFO - 'log_name': 'talos', 05:07:30 INFO - 'log_to_console': True, 05:07:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:30 INFO - 'opt_config_files': (), 05:07:30 INFO - 'pip_index': False, 05:07:30 INFO - 'sps_profile': False, 05:07:30 INFO - 'sps_profile_interval': 0, 05:07:30 INFO - 'suite': 'dromaeojs', 05:07:30 INFO - 'system_bits': '32', 05:07:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:30 INFO - 'title': 'talos-linux64-ix-043', 05:07:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:30 INFO - 'use_talos_json': True, 05:07:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:30 INFO - 'work_dir': 'build'} 05:07:30 INFO - ##### 05:07:30 INFO - ##### Running clobber step. 05:07:30 INFO - ##### 05:07:30 INFO - Running pre-action listener: _resource_record_pre_action 05:07:30 INFO - Running main action method: clobber 05:07:30 INFO - rmtree: /builds/slave/test/build 05:07:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:30 INFO - Running post-action listener: _resource_record_post_action 05:07:30 INFO - ##### 05:07:30 INFO - ##### Running read-buildbot-config step. 05:07:30 INFO - ##### 05:07:30 INFO - Running pre-action listener: _resource_record_pre_action 05:07:30 INFO - Running main action method: read_buildbot_config 05:07:30 INFO - Using buildbot properties: 05:07:30 INFO - { 05:07:30 INFO - "project": "", 05:07:30 INFO - "product": "firefox", 05:07:30 INFO - "script_repo_revision": "production", 05:07:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:07:30 INFO - "repository": "", 05:07:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:07:30 INFO - "buildid": "20160415023022", 05:07:30 INFO - "pgo_build": "True", 05:07:30 INFO - "basedir": "/builds/slave/test", 05:07:30 INFO - "buildnumber": 582, 05:07:30 INFO - "slavename": "talos-linux64-ix-043", 05:07:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:07:30 INFO - "platform": "ubuntu64_hw", 05:07:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:07:30 INFO - "branch": "fx-team", 05:07:30 INFO - "repo_path": "integration/fx-team", 05:07:30 INFO - "revision": "529cff9c5663a3581dfb5e690727144f07e8e23c", 05:07:30 INFO - "stage_platform": "linux64-pgo", 05:07:30 INFO - "builduid": "609f883fb5e14518841e3b8e27c3afb5", 05:07:30 INFO - "slavebuilddir": "test" 05:07:30 INFO - } 05:07:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:07:30 INFO - Running post-action listener: _resource_record_post_action 05:07:30 INFO - ##### 05:07:30 INFO - ##### Running download-and-extract step. 05:07:30 INFO - ##### 05:07:30 INFO - Running pre-action listener: _resource_record_pre_action 05:07:30 INFO - Running main action method: download_and_extract 05:07:30 INFO - mkdir: /builds/slave/test/build/tests 05:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:30 INFO - https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:07:31 INFO - Downloaded 1361 bytes. 05:07:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:31 INFO - Using the following test package requirements: 05:07:31 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:31 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:31 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:31 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'jsshell-linux-x86_64.zip'], 05:07:31 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:31 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:31 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:31 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:31 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:31 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07: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')]} 05:07:31 INFO - https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:34 INFO - Downloaded 23774096 bytes. 05:07:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:35 INFO - Return code: 0 05:07:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:07:35 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')]} 05:07:35 INFO - https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:37 INFO - Downloaded 23774096 bytes. 05:07:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:39 INFO - Return code: 0 05:07:39 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')]} 05:07:39 INFO - https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:07:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:07:41 INFO - Downloaded 10841076 bytes. 05:07:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:07:41 INFO - Return code: 0 05:07:41 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')]} 05:07:41 INFO - https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:07:46 INFO - Downloaded 58186811 bytes. 05:07:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:46 INFO - mkdir: /builds/slave/test/properties 05:07:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:46 INFO - Contents: 05:07:46 INFO - build_url:https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:47 INFO - Running post-action listener: _resource_record_post_action 05:07:47 INFO - Running post-action listener: set_extra_try_arguments 05:07:47 INFO - ##### 05:07:47 INFO - ##### Running populate-webroot step. 05:07:47 INFO - ##### 05:07:47 INFO - Running pre-action listener: _resource_record_pre_action 05:07:47 INFO - Running main action method: populate_webroot 05:07:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:47 INFO - '--tppagecycles', 05:07:47 INFO - '7'], 05:07:47 INFO - 'tests': ['tsvgm']}}, 05:07:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['damp', 'tps']}, 05:07:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'tests': ['damp', 'tps']}, 05:07:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['dromaeo_dom']}, 05:07:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['a11yr', 05:07:47 INFO - 'ts_paint', 05:07:47 INFO - 'tpaint', 05:07:47 INFO - 'sessionrestore', 05:07:47 INFO - 'sessionrestore_no_auto_restore', 05:07:47 INFO - 'tabpaint']}, 05:07:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:47 INFO - 'ts_paint', 05:07:47 INFO - 'tpaint', 05:07:47 INFO - 'sessionrestore', 05:07:47 INFO - 'sessionrestore_no_auto_restore', 05:07:47 INFO - 'tabpaint']}, 05:07:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:47 INFO - 'ts_paint', 05:07:47 INFO - 'tpaint', 05:07:47 INFO - 'sessionrestore', 05:07:47 INFO - 'sessionrestore_no_auto_restore', 05:07:47 INFO - 'tabpaint']}, 05:07:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:47 INFO - 'ts_paint', 05:07:47 INFO - 'tpaint', 05:07:47 INFO - 'sessionrestore', 05:07:47 INFO - 'sessionrestore_no_auto_restore', 05:07:47 INFO - 'tabpaint']}, 05:07:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['a11yr', 05:07:47 INFO - 'ts_paint', 05:07:47 INFO - 'tpaint', 05:07:47 INFO - 'sessionrestore', 05:07:47 INFO - 'sessionrestore_no_auto_restore', 05:07:47 INFO - 'tabpaint']}, 05:07:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['a11yr', 05:07:47 INFO - 'ts_paint', 05:07:47 INFO - 'tpaint', 05:07:47 INFO - 'sessionrestore', 05:07:47 INFO - 'sessionrestore_no_auto_restore', 05:07:47 INFO - 'tabpaint']}, 05:07:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['tsvgx', 05:07:47 INFO - 'tsvgr_opacity', 05:07:47 INFO - 'tart', 05:07:47 INFO - 'tscrollx', 05:07:47 INFO - 'cart']}, 05:07:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:47 INFO - 'tsvgr_opacity', 05:07:47 INFO - 'tart', 05:07:47 INFO - 'tscrollx', 05:07:47 INFO - 'cart']}, 05:07:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'talos_options': ['--disable-e10s'], 05:07:47 INFO - 'tests': ['tp5o']}, 05:07:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'tests': ['tp5o']}, 05:07:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'talos_options': ['--disable-e10s', 05:07:47 INFO - '--xperf_path', 05:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:47 INFO - 'tests': ['tp5n']}, 05:07:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:47 INFO - 'talos_options': ['--xperf_path', 05:07:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:47 INFO - 'tests': ['tp5n']}}, 05:07:47 INFO - 'talos.zip': {'path': '', 05:07:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:47 INFO - Running post-action listener: _resource_record_post_action 05:07:47 INFO - ##### 05:07:47 INFO - ##### Running create-virtualenv step. 05:07:47 INFO - ##### 05:07:47 INFO - Running pre-action listener: _resource_record_pre_action 05:07:47 INFO - Running main action method: create_virtualenv 05:07:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:07:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:47 INFO - Using real prefix '/usr' 05:07:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:49 INFO - Installing pip.................done. 05:07:49 INFO - Return code: 0 05:07:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:49 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 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:07:49 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 05:07:49 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 05:07:49 INFO - Using env: {'DISPLAY': ':0', 05:07:49 INFO - 'HOME': '/home/cltbld', 05:07:49 INFO - 'LANG': 'en_US.UTF-8', 05:07:49 INFO - 'LANGUAGE': 'en_US:en', 05:07:49 INFO - 'LOGNAME': 'cltbld', 05:07:49 INFO - 'MAIL': '/var/mail/cltbld', 05:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:49 INFO - 'MOZ_NO_REMOTE': '1', 05:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:49 INFO - 'NO_EM_RESTART': '1', 05:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:49 INFO - 'PWD': '/builds/slave/test', 05:07:49 INFO - 'SHELL': '/bin/bash', 05:07:49 INFO - 'SHLVL': '1', 05:07:49 INFO - 'TERM': 'linux', 05:07:49 INFO - 'TMOUT': '86400', 05:07:49 INFO - 'USER': 'cltbld', 05:07:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:49 INFO - '_': '/tools/buildbot/bin/python'} 05:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:49 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 05:07:49 INFO - Cleaning up... 05:07:49 INFO - Return code: 0 05:07:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:49 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:07:49 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>=0.7.1'] in /builds/slave/test/build 05:07:49 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>=0.7.1 05:07:49 INFO - Using env: {'DISPLAY': ':0', 05:07:49 INFO - 'HOME': '/home/cltbld', 05:07:49 INFO - 'LANG': 'en_US.UTF-8', 05:07:49 INFO - 'LANGUAGE': 'en_US:en', 05:07:49 INFO - 'LOGNAME': 'cltbld', 05:07:49 INFO - 'MAIL': '/var/mail/cltbld', 05:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:49 INFO - 'MOZ_NO_REMOTE': '1', 05:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:49 INFO - 'NO_EM_RESTART': '1', 05:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:49 INFO - 'PWD': '/builds/slave/test', 05:07:49 INFO - 'SHELL': '/bin/bash', 05:07:49 INFO - 'SHLVL': '1', 05:07:49 INFO - 'TERM': 'linux', 05:07:49 INFO - 'TMOUT': '86400', 05:07:49 INFO - 'USER': 'cltbld', 05:07:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:49 INFO - '_': '/tools/buildbot/bin/python'} 05:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:50 INFO - Downloading/unpacking psutil>=0.7.1 05:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:52 INFO - Installing collected packages: psutil 05:07:52 INFO - Running setup.py install for psutil 05:07:52 INFO - building 'psutil._psutil_linux' extension 05:07:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:07:52 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 05:07:52 INFO - building 'psutil._psutil_posix' extension 05:07:52 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 05:07:52 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 05:07:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:52 INFO - Successfully installed psutil 05:07:52 INFO - Cleaning up... 05:07:52 INFO - Return code: 0 05:07:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:07:52 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')]} 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:52 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')]} 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:52 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:07:52 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.0.0'] in /builds/slave/test/build 05:07:52 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.0.0 05:07:52 INFO - Using env: {'DISPLAY': ':0', 05:07:52 INFO - 'HOME': '/home/cltbld', 05:07:52 INFO - 'LANG': 'en_US.UTF-8', 05:07:52 INFO - 'LANGUAGE': 'en_US:en', 05:07:52 INFO - 'LOGNAME': 'cltbld', 05:07:52 INFO - 'MAIL': '/var/mail/cltbld', 05:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:52 INFO - 'MOZ_NO_REMOTE': '1', 05:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:52 INFO - 'NO_EM_RESTART': '1', 05:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:52 INFO - 'PWD': '/builds/slave/test', 05:07:52 INFO - 'SHELL': '/bin/bash', 05:07:52 INFO - 'SHLVL': '1', 05:07:52 INFO - 'TERM': 'linux', 05:07:52 INFO - 'TMOUT': '86400', 05:07:52 INFO - 'USER': 'cltbld', 05:07:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:52 INFO - '_': '/tools/buildbot/bin/python'} 05:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:07:52 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 05:07:52 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 05:07:52 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 05:07:52 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 05:07:52 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 05:07:52 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 05:07:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:07:54 INFO - Installing collected packages: mozsystemmonitor 05:07:54 INFO - Running setup.py install for mozsystemmonitor 05:07:54 INFO - Successfully installed mozsystemmonitor 05:07:54 INFO - Cleaning up... 05:07:54 INFO - Return code: 0 05:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:54 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')]} 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:54 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')]} 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:54 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 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:07:54 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 05:07:54 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 05:07:54 INFO - Using env: {'DISPLAY': ':0', 05:07:54 INFO - 'HOME': '/home/cltbld', 05:07:54 INFO - 'LANG': 'en_US.UTF-8', 05:07:54 INFO - 'LANGUAGE': 'en_US:en', 05:07:54 INFO - 'LOGNAME': 'cltbld', 05:07:54 INFO - 'MAIL': '/var/mail/cltbld', 05:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:54 INFO - 'MOZ_NO_REMOTE': '1', 05:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:54 INFO - 'NO_EM_RESTART': '1', 05:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:54 INFO - 'PWD': '/builds/slave/test', 05:07:54 INFO - 'SHELL': '/bin/bash', 05:07:54 INFO - 'SHLVL': '1', 05:07:54 INFO - 'TERM': 'linux', 05:07:54 INFO - 'TMOUT': '86400', 05:07:54 INFO - 'USER': 'cltbld', 05:07:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:54 INFO - '_': '/tools/buildbot/bin/python'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:57 INFO - Downloading docopt-0.6.1.tar.gz 05:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:57 INFO - Running setup.py install for blobuploader 05:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:57 INFO - Running setup.py install for requests 05:07:58 INFO - Running setup.py install for docopt 05:07:58 INFO - Successfully installed blobuploader requests docopt 05:07:58 INFO - Cleaning up... 05:07:58 INFO - Return code: 0 05:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 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 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:07:58 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 05:07:58 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 05:07:58 INFO - Using env: {'DISPLAY': ':0', 05:07:58 INFO - 'HOME': '/home/cltbld', 05:07:58 INFO - 'LANG': 'en_US.UTF-8', 05:07:58 INFO - 'LANGUAGE': 'en_US:en', 05:07:58 INFO - 'LOGNAME': 'cltbld', 05:07:58 INFO - 'MAIL': '/var/mail/cltbld', 05:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:58 INFO - 'MOZ_NO_REMOTE': '1', 05:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:58 INFO - 'NO_EM_RESTART': '1', 05:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:58 INFO - 'PWD': '/builds/slave/test', 05:07:58 INFO - 'SHELL': '/bin/bash', 05:07:58 INFO - 'SHLVL': '1', 05:07:58 INFO - 'TERM': 'linux', 05:07:58 INFO - 'TMOUT': '86400', 05:07:58 INFO - 'USER': 'cltbld', 05:07:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:58 INFO - '_': '/tools/buildbot/bin/python'} 05:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 INFO - Running setup.py (path:/tmp/pip-wF3j2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:58 INFO - Running setup.py (path:/tmp/pip-ooJO4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:58 INFO - Running setup.py (path:/tmp/pip-rFe903-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:58 INFO - Running setup.py (path:/tmp/pip-JbcVbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:58 INFO - Running setup.py (path:/tmp/pip-W0Upn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:58 INFO - Running setup.py (path:/tmp/pip-pnSLOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:58 INFO - Running setup.py (path:/tmp/pip-HpET_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:59 INFO - Running setup.py (path:/tmp/pip-H_QT8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:59 INFO - Running setup.py (path:/tmp/pip-0wvKvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:59 INFO - Running setup.py (path:/tmp/pip-9Gj8w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 INFO - Running setup.py (path:/tmp/pip-tgcDti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 INFO - Running setup.py (path:/tmp/pip-jQhwl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 INFO - Running setup.py (path:/tmp/pip-TrwvE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 INFO - Running setup.py (path:/tmp/pip-FhMSgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 INFO - Running setup.py (path:/tmp/pip-p9YIXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:59 INFO - Running setup.py (path:/tmp/pip-Sgq9wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:59 INFO - Running setup.py (path:/tmp/pip-2r1Prw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:59 INFO - Running setup.py install for manifestparser 05:07:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:59 INFO - Running setup.py install for mozcrash 05:07:59 INFO - Running setup.py install for mozdebug 05:08:00 INFO - Running setup.py install for mozdevice 05:08:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozfile 05:08:00 INFO - Running setup.py install for mozhttpd 05:08:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozinfo 05:08:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozInstall 05:08:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozleak 05:08:00 INFO - Running setup.py install for mozlog 05:08:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for moznetwork 05:08:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozprocess 05:08:00 INFO - Running setup.py install for mozprofile 05:08:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Running setup.py install for mozrunner 05:08:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Running setup.py install for mozscreenshot 05:08:01 INFO - Running setup.py install for moztest 05:08:01 INFO - Running setup.py install for mozversion 05:08:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:01 INFO - Cleaning up... 05:08:01 INFO - Return code: 0 05:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:01 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 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:08:01 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 05:08:01 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 05:08:01 INFO - Using env: {'DISPLAY': ':0', 05:08:01 INFO - 'HOME': '/home/cltbld', 05:08:01 INFO - 'LANG': 'en_US.UTF-8', 05:08:01 INFO - 'LANGUAGE': 'en_US:en', 05:08:01 INFO - 'LOGNAME': 'cltbld', 05:08:01 INFO - 'MAIL': '/var/mail/cltbld', 05:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:01 INFO - 'MOZ_NO_REMOTE': '1', 05:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:01 INFO - 'NO_EM_RESTART': '1', 05:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:01 INFO - 'PWD': '/builds/slave/test', 05:08:01 INFO - 'SHELL': '/bin/bash', 05:08:01 INFO - 'SHLVL': '1', 05:08:01 INFO - 'TERM': 'linux', 05:08:01 INFO - 'TMOUT': '86400', 05:08:01 INFO - 'USER': 'cltbld', 05:08:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:01 INFO - '_': '/tools/buildbot/bin/python'} 05:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:01 INFO - Running setup.py (path:/tmp/pip-8Lf7Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:01 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)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:01 INFO - Running setup.py (path:/tmp/pip-xrYWsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:01 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)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:01 INFO - Running setup.py (path:/tmp/pip-yP4pUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:01 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)) 05:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:01 INFO - Running setup.py (path:/tmp/pip-4rivYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:02 INFO - Running setup.py (path:/tmp/pip-lh0g56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:02 INFO - Running setup.py (path:/tmp/pip-oNiN2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:02 INFO - Running setup.py (path:/tmp/pip-flh6HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:02 INFO - Running setup.py (path:/tmp/pip-FWDE2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:02 INFO - Running setup.py (path:/tmp/pip-D1w02r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:02 INFO - Running setup.py (path:/tmp/pip-IedUpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:02 INFO - Running setup.py (path:/tmp/pip-J_Xg8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:02 INFO - Running setup.py (path:/tmp/pip-j5LbKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:02 INFO - Running setup.py (path:/tmp/pip-3d0e9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:02 INFO - Running setup.py (path:/tmp/pip-I1hqZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:02 INFO - Running setup.py (path:/tmp/pip-WzMcxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:02 INFO - Running setup.py (path:/tmp/pip-n8lKHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:02 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)) 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:02 INFO - Running setup.py (path:/tmp/pip-8FEUeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:02 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)) 05:08:03 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)) 05:08:03 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)) 05:08:03 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)) 05:08:03 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)) 05:08:03 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)) 05:08:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:04 INFO - Downloading blessings-1.6.tar.gz 05:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:04 INFO - Installing collected packages: blessings 05:08:04 INFO - Running setup.py install for blessings 05:08:05 INFO - Successfully installed blessings 05:08:05 INFO - Cleaning up... 05:08:05 INFO - Return code: 0 05:08:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:05 INFO - Reading from file tmpfile_stdout 05:08:05 INFO - Current package versions: 05:08:05 INFO - argparse == 1.2.1 05:08:05 INFO - blessings == 1.6 05:08:05 INFO - blobuploader == 1.2.4 05:08:05 INFO - docopt == 0.6.1 05:08:05 INFO - manifestparser == 1.1 05:08:05 INFO - mozInstall == 1.12 05:08:05 INFO - mozcrash == 0.17 05:08:05 INFO - mozdebug == 0.1 05:08:05 INFO - mozdevice == 0.48 05:08:05 INFO - mozfile == 1.2 05:08:05 INFO - mozhttpd == 0.7 05:08:05 INFO - mozinfo == 0.9 05:08:05 INFO - mozleak == 0.1 05:08:05 INFO - mozlog == 3.1 05:08:05 INFO - moznetwork == 0.27 05:08:05 INFO - mozprocess == 0.22 05:08:05 INFO - mozprofile == 0.28 05:08:05 INFO - mozrunner == 6.11 05:08:05 INFO - mozscreenshot == 0.1 05:08:05 INFO - mozsystemmonitor == 0.0 05:08:05 INFO - moztest == 0.7 05:08:05 INFO - mozversion == 1.4 05:08:05 INFO - psutil == 3.1.1 05:08:05 INFO - requests == 1.2.3 05:08:05 INFO - wsgiref == 0.1.2 05:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:05 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 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:08:05 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 05:08:05 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 05:08:05 INFO - Using env: {'DISPLAY': ':0', 05:08:05 INFO - 'HOME': '/home/cltbld', 05:08:05 INFO - 'LANG': 'en_US.UTF-8', 05:08:05 INFO - 'LANGUAGE': 'en_US:en', 05:08:05 INFO - 'LOGNAME': 'cltbld', 05:08:05 INFO - 'MAIL': '/var/mail/cltbld', 05:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:05 INFO - 'MOZ_NO_REMOTE': '1', 05:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:05 INFO - 'NO_EM_RESTART': '1', 05:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:05 INFO - 'PWD': '/builds/slave/test', 05:08:05 INFO - 'SHELL': '/bin/bash', 05:08:05 INFO - 'SHLVL': '1', 05:08:05 INFO - 'TERM': 'linux', 05:08:05 INFO - 'TMOUT': '86400', 05:08:05 INFO - 'USER': 'cltbld', 05:08:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:05 INFO - '_': '/tools/buildbot/bin/python'} 05:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 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)) 05:08:05 INFO - Cleaning up... 05:08:05 INFO - Return code: 0 05:08:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:05 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 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:08:05 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 05:08:05 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 05:08:05 INFO - Using env: {'DISPLAY': ':0', 05:08:05 INFO - 'HOME': '/home/cltbld', 05:08:05 INFO - 'LANG': 'en_US.UTF-8', 05:08:05 INFO - 'LANGUAGE': 'en_US:en', 05:08:05 INFO - 'LOGNAME': 'cltbld', 05:08:05 INFO - 'MAIL': '/var/mail/cltbld', 05:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:05 INFO - 'MOZ_NO_REMOTE': '1', 05:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:05 INFO - 'NO_EM_RESTART': '1', 05:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:05 INFO - 'PWD': '/builds/slave/test', 05:08:05 INFO - 'SHELL': '/bin/bash', 05:08:05 INFO - 'SHLVL': '1', 05:08:05 INFO - 'TERM': 'linux', 05:08:05 INFO - 'TMOUT': '86400', 05:08:05 INFO - 'USER': 'cltbld', 05:08:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:05 INFO - '_': '/tools/buildbot/bin/python'} 05:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:05 INFO - Downloading/unpacking jsonschema 05:08:05 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 05:08:05 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 05:08:05 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 05:08:05 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 05:08:05 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 05:08:05 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 05:08:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:07 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 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 05:08:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:07 INFO - warning: no files found matching '*.txt' 05:08:07 INFO - no previously-included directories found matching 'build' 05:08:07 INFO - no previously-included directories found matching 'dist' 05:08:07 INFO - no previously-included directories found matching '.git*' 05:08:07 INFO - Installing collected packages: jsonschema, functools32 05:08:07 INFO - Running setup.py install for functools32 05:08:08 INFO - warning: no files found matching '*.txt' 05:08:08 INFO - no previously-included directories found matching 'build' 05:08:08 INFO - no previously-included directories found matching 'dist' 05:08:08 INFO - no previously-included directories found matching '.git*' 05:08:08 INFO - Successfully installed jsonschema functools32 05:08:08 INFO - Cleaning up... 05:08:08 INFO - Return code: 0 05:08:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f478970df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, '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': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', '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 05:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:08:08 INFO - Using env: {'DISPLAY': ':0', 05:08:08 INFO - 'HOME': '/home/cltbld', 05:08:08 INFO - 'LANG': 'en_US.UTF-8', 05:08:08 INFO - 'LANGUAGE': 'en_US:en', 05:08:08 INFO - 'LOGNAME': 'cltbld', 05:08:08 INFO - 'MAIL': '/var/mail/cltbld', 05:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:08 INFO - 'MOZ_NO_REMOTE': '1', 05:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:08 INFO - 'NO_EM_RESTART': '1', 05:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:08 INFO - 'PWD': '/builds/slave/test', 05:08:08 INFO - 'SHELL': '/bin/bash', 05:08:08 INFO - 'SHLVL': '1', 05:08:08 INFO - 'TERM': 'linux', 05:08:08 INFO - 'TMOUT': '86400', 05:08:08 INFO - 'USER': 'cltbld', 05:08:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:08 INFO - '_': '/tools/buildbot/bin/python'} 05:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:08 INFO - Downloading/unpacking flake8 05:08:08 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 05:08:08 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 05:08:08 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 05:08:08 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 05:08:08 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 05:08:08 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 05:08:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 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 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:10 INFO - no previously-included directories found matching 'docs/_build' 05:08:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:11 INFO - Running setup.py install for pep8 05:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:11 INFO - no previously-included directories found matching 'docs/_build' 05:08:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:11 INFO - Cleaning up... 05:08:11 INFO - Return code: 0 05:08:11 INFO - Running post-action listener: _resource_record_post_action 05:08:11 INFO - Running post-action listener: _start_resource_monitoring 05:08:11 INFO - Starting resource monitoring. 05:08:11 INFO - ##### 05:08:11 INFO - ##### Running install step. 05:08:11 INFO - ##### 05:08:11 INFO - Running pre-action listener: _resource_record_pre_action 05:08:11 INFO - Running main action method: install 05:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:11 INFO - Reading from file tmpfile_stdout 05:08:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:11 INFO - Reading from file tmpfile_stdout 05:08:11 INFO - Output received: 05:08:11 INFO - Usage: mozinstall [options] installer 05:08:11 INFO - Options: 05:08:11 INFO - -h, --help show this help message and exit 05:08:11 INFO - -d DEST, --destination=DEST 05:08:11 INFO - Directory to install application into. [default: 05:08:11 INFO - "/builds/slave/test"] 05:08:11 INFO - --app=APP Application being installed. [default: firefox] 05:08:11 INFO - mkdir: /builds/slave/test/build/application 05:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:08:28 INFO - Reading from file tmpfile_stdout 05:08:28 INFO - Output received: 05:08:28 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:28 INFO - Running post-action listener: _resource_record_post_action 05:08:28 INFO - ##### 05:08:28 INFO - ##### Running run-tests step. 05:08:28 INFO - ##### 05:08:28 INFO - Running pre-action listener: _resource_record_pre_action 05:08:28 INFO - Running main action method: run_tests 05:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:28 INFO - Python 2.7.3 05:08:28 INFO - Return code: 0 05:08:28 INFO - grabbing minidump binary from tooltool 05:08:28 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')]} 05:08:28 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1706810>, '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 0x1707710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1707ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:28 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 05:08:28 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 05:08:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:28 INFO - Return code: 0 05:08:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:29 INFO - Return code: 0 05:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 05:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 05:08:29 INFO - Using env: {'DISPLAY': ':0', 05:08:29 INFO - 'HOME': '/home/cltbld', 05:08:29 INFO - 'LANG': 'en_US.UTF-8', 05:08:29 INFO - 'LANGUAGE': 'en_US:en', 05:08:29 INFO - 'LOGNAME': 'cltbld', 05:08:29 INFO - 'MAIL': '/var/mail/cltbld', 05:08:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:29 INFO - 'MOZ_NO_REMOTE': '1', 05:08:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:29 INFO - 'NO_EM_RESTART': '1', 05:08:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:29 INFO - 'PWD': '/builds/slave/test', 05:08:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:29 INFO - 'SHELL': '/bin/bash', 05:08:29 INFO - 'SHLVL': '1', 05:08:29 INFO - 'TERM': 'linux', 05:08:29 INFO - 'TMOUT': '86400', 05:08:29 INFO - 'USER': 'cltbld', 05:08:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937', 05:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:29 INFO - '_': '/tools/buildbot/bin/python'} 05:08:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 05:08:29 INFO - mozversion application_buildid: 20160415023022 05:08:29 INFO - mozversion application_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 05:08:29 INFO - mozversion application_display_name: Nightly 05:08:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:29 INFO - mozversion application_name: Firefox 05:08:29 INFO - mozversion application_remotingname: firefox 05:08:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:29 INFO - mozversion application_vendor: Mozilla 05:08:29 INFO - mozversion application_version: 48.0a1 05:08:29 INFO - mozversion platform_buildid: 20160415023022 05:08:29 INFO - mozversion platform_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 05:08:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:29 INFO - mozversion platform_version: 48.0a1 05:08:29 INFO - using testdate: 1460722109 05:08:29 INFO - actual date: 1460722109 05:08:29 INFO - starting webserver on 'localhost:37140' 05:08:29 INFO - SUITE-START | Running 2 tests 05:08:29 INFO - TEST-START | dromaeo_css 05:08:29 INFO - operating with platform_type : linux_ 05:08:29 INFO - Initialising browser for dromaeo_css test... 05:08:29 INFO - TEST-INFO | started process 6310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp520BQQ/profile http://localhost:37140/getInfo.html) 05:08:33 INFO - PROCESS | 6310 | __metrics Screen width/height:1600/1200 05:08:33 INFO - PROCESS | 6310 | colorDepth:24 05:08:33 INFO - PROCESS | 6310 | Browser inner width/height: 1024/697 05:08:33 INFO - PROCESS | 6310 | __metrics 05:08:34 ERROR - PROCESS | 6310 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:08:35 INFO - TEST-INFO | 6310: exit 0 05:08:35 INFO - Browser initialized. 05:08:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:35 INFO - TEST-INFO | started process 6392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp520BQQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:46 INFO - PROCESS | 6392 | RSS: Main: 153653248 05:08:46 INFO - PROCESS | 6392 | 05:09:37 INFO - PROCESS | 6392 | 1460722177918 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] 05:11:45 INFO - PROCESS | 6392 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37140/tests/dromaeo/cssquery-ext.html) 05:11:46 INFO - PROCESS | 6392 | RSS: Main: 251953152 05:11:46 INFO - PROCESS | 6392 | 05:14:48 INFO - PROCESS | 6392 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-ext.html (next: http://localhost:37140/tests/dromaeo/cssquery-jquery.html) 05:14:48 INFO - PROCESS | 6392 | RSS: Main: 234266624 05:14:48 INFO - PROCESS | 6392 | 05:17:50 INFO - PROCESS | 6392 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37140/tests/dromaeo/cssquery-mootools.html) 05:17:51 INFO - PROCESS | 6392 | RSS: Main: 239247360 05:17:51 INFO - PROCESS | 6392 | 05:20:53 INFO - PROCESS | 6392 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37140/tests/dromaeo/cssquery-prototype.html) 05:20:53 INFO - PROCESS | 6392 | RSS: Main: 232763392 05:20:53 INFO - PROCESS | 6392 | 05:23:56 INFO - PROCESS | 6392 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37140/tests/dromaeo/cssquery-yui.html) 05:23:57 INFO - PROCESS | 6392 | RSS: Main: 221732864 05:23:57 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-yui.html (next: http://localhost:37140/tests/dromaeo/cssquery-dojo.html) 05:26:59 INFO - PROCESS | 6392 | RSS: Main: 266465280 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | __start_tp_report 05:26:59 INFO - PROCESS | 6392 | _x_x_mozilla_page_load 05:26:59 INFO - PROCESS | 6392 | _x_x_mozilla_page_load_details 05:26:59 INFO - PROCESS | 6392 | |i|pagename|runs| 05:26:59 INFO - PROCESS | 6392 | |0;dojo.html;3079.045495896272;3107.238726512005;3148.9370212595736;3154.1010811918595;3178.316661917688;5252.133397989332;5266.789328426863;5291.153415453528;5297.920531192026;5365.7585408656605;5286.735663216833;5307.150855863063;5331.360236771593;5362.597805164609;5403.2165336026255;4796.352492413532;4800.42394912611;4813.085513752393;4860.684055536379;4965.602751779849;4923.236898280755;4939;4944.901101977958;5000.674956127858;5011.574016208627;4781.880452988668;4817.205161148407;4818.132736107499;4848.369711937443;4905.73018483985;4872.269159626085;4872.56146946773;4885;4887.780049897763;4914.582260507826;4730.526947305242;4844.249141383091;4864.221724524059;4870.123377791996;4897.118518666639;5181.766820493049;5222.321098257202;5248.685078895279;5286.577073834084;5296.867578310535;5464.4262352452815;5490.890182196334;5491.121420572689;5496.258005169331;5511.944880551183;5555.861103472405;5561.277033985596;5565.582581306418;5580.414056524047;5631.21163037171;5326.307580014573;5347.49198826107;5363.06146424378;5390.703511306877;5396.568274538027;5801.53587712982;5818.738156782955;5819.243498345188;5821.563382746311;5822.94177058224;5475.589330800206;5477;5560.2493663355735;5585.748641311151;5610.663360198401;5576.358718747315;5578.135389014709;5581.162825576196;5582.609217354828;5614.073677843192;5555.138953462219;5558.166275058774;5560.805371811967;5562.276904002454;5564.749586268627;5439.456054394529;5608.242887210256;5712.714364281853;5759.94240057594;5810.6513609183585;4295.613394794484;4305.784710764449;4307.8492252771;4311.741295522279;4341.978290108593;3829.483019792348;3879.476270703475;3893.6106389361403;3905.804709764557;3911.06134527717;5273.367195936512;5297.443768404262;5365.222042803772;5368.973155134199;5378.892422151535;5714.142878568248;5729.255196824386;5730.5129064030025;5746.540276777848;5760.53915686744;5355.3305836770405;5381.327334083239;5429.67421954684;5430.8913821723345;5474.151506516497;4676.906461870743;4760.047990401933;4786.593139583175;4829;4837.975810120997;5854.414558544111;5896.970515147397;5897.174395584621;5900.262467191601;5907.409259074058;5564.38791732901;5658.999999999917;5673.461021202979;5682.147677848356;5685.829425117253;5879.7060146993335;5903.321118071477;5909.734061967136;5924.940750592439;5941.405859414197;5458.181272809111;5475.534579560782;5475.67145971243;5477.233187353694;5480.890382192413;5475.945240547543;5521.475459831309;5548.140038294071;5549.722513874371;5551.333839939233;5520.1167813149705;5564.805231817029;5566.860828479321;5572.526335261548;5609.831705048855;5479.945200547943;5543.805966791143;5562.11006239016;5564.888702226014;5566.777328906798;5256.842294731164;5322.707251101227;5336.606345452565;5393.730313484231;5453.809116680897;5575.581831362583;5578.3584887738425;5582.106862901916;5588.804391846428;5604.355499117653;5427.48438898304;5452.809151679672;5460.262864513399;5463.918041229305;5465.180222966428 05:26:59 INFO - PROCESS | 6392 | |1;ext.html;620.0791824141149;644.1111266452295;670.8289386206517;673.4376795375861;676.7732809508815;29789.404211915775;37397.62602373975;38089.23821523568;38108;38311.80844095779;40747;41605.375919361235;41656;41687.374689379605;41793.7910310448;7865.174156713549;8481.91518084819;8717.433366831136;8736.126387361277;10090.848637270446;10152.34009789365;10348.844767328495;10348.896511034869;10352.689419317432;10353.275270731052;10299.07308342249;10395.636152734656;10398.22013348998;10404.115650169744;10413.895861041407;7845.2547008034435;8037.718679846177;10282.280240383176;10340.379577225316;10713.410762408064;10195.796084078276;10351;10356.637517686844;10358.378497290187;10361.48192590375;37986.620133798584;38551.03622409434;38666;38680.61319386798;38768.22463550713;3525.541679581638;3553.466979953002;3800.657940785343;3922.1959498303063;3981.840726370942;31021.689783102105;31237.219069523217;31330.21674458134;31375.686243137505;31703.365932681216;4140.68944829136;4344.1963236800975;4397.098594788061;4448.6885917985755;4459;275887;277280.99999999796;278463;278496;279300;56449;56509.434905650414;57087.14369284464;57111.42888571061;57125.71437142871;62969.685151574864;65440.672796635714;65691.67154164294;65854.34145658482;65883.34116658868;16719.247633856507;17013;17015.744763828552;17035.233414496128;17038.403655871985;13273.66815829612;13315.600531984055;13367;13370.933145334406;13378.397972091085;18739.09544020679;18886.43340699781;18977.335793247446;19566;19710.211591536463;7168;7249.347558719741;7311.195768465464;7405.8889116663295;7408.481406301615;895.4448242089946;969.1519920069939;1042.598599539183;1135.4833550734395;1154.5151036564664;27025.459490810073;28315.82035814968;31022.844885775427;31316.686833131378;31443.842780785948;1149.8562679665042;1182.8639706433871;1197.3773637708516;1204.5723768062387;1214.0530386298701;16793.832061679226;16817.83182168187;16821.57946051334;16851.325946961984;16927.322907083824;427967;435169;437346;437671;439092;54053.72973135109;55805.7209713957;55842.44157558454;55906.44093559012;55925;1399.3702833724865;1399.4472183487464;1416.872481476672;1417.2701058954647;1445.0101680348994;29586;30355;30362.696373035986;30597.54103688491;30795.53806692946;48289;49045.5095449041;49057.26414103863;49095.50904491052;49100.26349604687;386873;393071;394393;394986;396619;25119.24642260735;27084.187474375012;27343.72656273412;27431.86284068567;28066.85966570154;39895;40295;40535.797321013204;41192.970175745846;41569.79215103905;34011.4898276531;34315.4852677215;34327.828360859035;34343.31313373768;35200.471992919614;37797.43303850389;38042.61957380391;38110.618893811814;38411.6158838408;38472.80763596164;40216.79891600523;40276.3958540628;41339.379909300784;41594;41734.37398439086;30446.23884402819;31648.367032658756;31813.5227971576;31879.20301992376;31993.6800632;25105;25413.61879571845;25480.362990925376;25508;25673.486530269663 05:26:59 INFO - PROCESS | 6392 | |2;jquery.html;385.2449199568846;396.9940450893237;398.2155154345937;399;400.17563818533824;17710.73433898491;17916;18423.539411514703;18443.90778046108;20379.08294126768;18459.907700461514;19236.3267285645;19252;19388.22447102114;19549.804501954975;5601.943980560183;5690.089585666305;5766.913496297559;5849.093390524476;5885.61743486672;5769.826905192851;5774.913376299359;5775.393583673716;5786.363500014995;5797.246357973458;5499.257600223958;5671.8582035449235;5681.147827825838;5753.367129615739;5756.194132821408;5683.204351390788;5700.80283140541;5702.743376548045;5718.7426565804635;5743.081107022877;4864.975675121637;5156.226566015091;5161.200013997836;5164.948350516522;5175.456577059392;22405.32784016482;22412.767297798615;22454;23189.42026449352;23291.18480853179;2357.988210058939;2427.927162185137;2456.6437866509436;2524.911628093026;2694.2456112288396;14079.718405631933;14335.996480246387;14354.425822967069;14752.483663071742;14801.481948131765;1905.237904838062;1957.0606109067728;1962.3426152238874;2004.258424382973;2059.5263089489354;58471.70764146152;70951;73725.6313718428;79709.60145199294;81631.18368816354;8641.740747777576;9699.272554558436;9819.509024548886;10213.438260895722;10800.459977001276;14984.850151498564;15030.473933412279;15195;15230.695386092217;15767.132807695687;8018.959905200553;8050.074241462306;8123.309518690978;8314.293285070837;8322.20939010793;7196.676149573177;7444.962775186198;7586.634405806897;7635.350995165473;7954.642041108048;4654.2785868190485;4720.197566413718;4733.715977041388;4749.810007599726;4804.495527969582;1951.3853136262032;2014.8891810950245;2018.9091490882652;2043.4074118505466;2056.4344805178694;931.855562387831;1039.449091981251;1054.2304117993908;1092.5738961804902;1102.7573933734566;18217.362392316205;18363.540911477052;18975.146118424705;19396;19563.706544401844;1018.332991890313;1030.577463240083;1034.7775228325945;1046.8325067989085;1088.2491081153978;10317.761868575819;10955.780884382268;10965.232433729563;10994.780104398027;11022.944885275523;372257;376668;394739;442952;445372;87814.56092719495;88916;89357.08536030451;89576;90035.09964900267;1019.23557332001;1048.0567489259574;1049.7952899184738;1096.13405409727;1111.6387174168428;17289.135543222535;17294.481165565052;17348.913255433643;17476.213570389617;17486.73769893427;36578.45132322964;37369;38146.2370752589;38636.61363386443;42646.5735342655;50564;52158;52287.47712522826;52579.21131182959;52852.207216892544;8331.16688331162;8342.08237093907;8348.833023339621;8351.415400921876;8567.057623661516;12154.453049612612;12527.686807829512;12785.680357991125;12819.230846149261;12831.807522886977;10940.45297735126;11340.94329528347;11382.943085284853;11410.486528106088;11474.827877582009;10973.670789876316;11048.558057677603;11119.388433636228;11149.331040137618;11478.770424591628;11189.552417903193;11195.328280303207;11289.096872250037;11563.884361156617;11815.76368472643;8372.41393102477;8429.40994130405;8501.532415717194;8522.573871306535;8648.481091134552;11555;11567.479463423997;11627.476763545492;11642.5342986283;11648.825267620823 05:26:59 INFO - PROCESS | 6392 | |3;mootools.html;1368.322680273265;1515.6286709756107;1573.9370425182992;1724.4654157211266;1874.962500749985;8054.315383192428;8406.579671016456;8411.495310281387;8415.789605259872;8432.53621050842;8131.512109273448;8331.500109993405;8347.081820999685;8354.206350396702;8355.707550235744;1937.5737337785665;2136.572685462906;2169.566086782642;2209.0611490116717;2217.4567231028423;2259.288324177887;2264.071730590458;2269.103704036904;2280.794728474437;2282.6461898405773;2129.4144110369616;2184.453886528368;2184.6613774864923;2189.386971647941;2189.6496560550313;1918.8177123173346;2120.162535798359;2183.563287342522;2184.530325979922;2184.541246338271;2105.2947262667026;2114.851960362775;2124.1184908263053;2127.606392817334;2133.903974321144;7944.165862584461;8067.959660201662;8070.959645201737;8072.19278072194;8078.192180781874;4811.59101476375;4960.280759289919;5000.924986125211;5012.323336349583;5069.315642388267;3106.176863131272;3110.5334199869976;3169.7464202863716;3180.236743181643;3195.2171717929023;1008.8587597736323;1058.6188971970084;1064.8402739589123;1070.946452677363;1071.7427817323864;11719.589814356541;11729.53081876724;11734.119941004545;11741.765164696744;11745.706357341049;4304.698671092993;4367.45406824147;4480.059187570647;4488.4613846338;4504.3919070925;9755.317127801127;9858.753531161778;9877.357971731815;9890.307678462583;9937.254705897087;4623.976880115578;5097.362829646294;5115.923261151086;5120.539151476385;5131.307273518102;4570;4644.558766917137;4660.184467718136;4660.440747110369;4672.556107169813;3730.0861288984374;3757.323681737259;3822.5604055533413;3829.9617003830163;3850.172212974224;1235.882591153839;1239.6116349688407;1252.874712528758;1253.6677780388204;1259.3136740476461;827.2430725885868;949.4066208619613;960.6829746183743;997.3517213810936;1016.339379403379;5811.622244554091;5836;5857.941420585739;5910.615809972338;6025.216721826135;1022.9130523905402;1097.2100087936674;1099.9065079468176;1111.1222034761229;1125.3754166437543;3865.033741564609;3969.186316805048;3973.145773658677;3980.8208630611693;4007.859724909614;9928.404295742279;10340.638077667245;10383;10407.375557466576;10417.427041512638;10015.949920250352;10043.849342259871;10082.899171008343;10400.791984160425;10570;7434.442416818652;7458.216887226763;7494.737684181027;7523.887141692879;7633.923660763321;5560.388357280615;5646.06839871433;5744.798932037359;5823.388544202798;5841.649501029782;9189.218916391914;9261.53692315368;9365.391249568756;9370.625174993196;9378.765530861783;8903.465792052497;9115.908840911507;9519.524023798644;9631.373960692532;9667.129958303787;6988;7319.74380896666;7385.8153546161775;7498.775036748906;7550.282723141293;8230.711925082593;8255.009398872175;8282.50304981703;8325.708600198965;8326.04250511199;7341.853162936818;7569.886451703339;7644.80887977805;7683.538987660758;7735.303822655988;7202.459815513753;7481.364084052916;7551;7634.656440460081;7639.388848891964;6317.241930968129;6317.399847014526;6356.682165891594;6357.618542887441;6368;5030.647854650139;5132.127538318569;5201.739913004259;5266.683998960075;5267.868303292448;4960.330355402119;4978.576820970114;5025;5071.873203169803;5115.897682046264 05:26:59 INFO - PROCESS | 6392 | |4;prototype.html;332.91469808424534;333.7180082830009;340.4994657852957;345.9619441861395;351.07841914973193;5762.567807414445;5840.211571437854;5848.941510584893;5874.001419758641;5891.145783861343;5398.757055932482;5561.360443548993;5734.423033665744;5757;5790.623609465381;4435.356873253392;4458.4872739634875;4466.33005049242;4471.441069866267;4487.483939346984;4467.53090925453;4481.529439408864;4481.753503557303;4481.977590112061;4494.505604383515;4120.58794120587;4261.190373828963;4404.955950440502;4408.338749187616;4419.845305414311;4379.1679580879845;4379.802908869076;4385.342198670193;4400.867973960786;4418.359337895987;3910.7066969977363;3919.9216015679526;3922.1371298314325;3925.9803700981597;3939.3697008478794;5296.788128474856;5537.335519737617;5560.833175004756;5586.078297081018;5595.356533998602;5061.44324124346;5065.088284108859;5076.06092872816;5092.10888094582;5102.260172275;5895.555588880752;6066.241719785027;6067.393260673942;6076.513878889678;6079.39206079393;4176.164767046573;4193.098483825962;4198;4198.286291330481;4209.34755112958;6256.1866957295715;6333.271673757485;6336.619802811846;6358.395952384516;6381.234251889803;4060.796960151981;4279.957200427956;4302.849400271038;4303.07483890965;4311.8490852820005;4396.912061758747;4424.424824772759;4427.203103441411;4432.445944256968;4441.333799930037;4973.254011898244;5001.474845141208;5025.773840177201;5068.695878247317;5080.441151473335;5962.314333851663;6057.121717350959;6094.329623741385;6117.265928088658;6127.111568822585;1429.6425893526618;1470.9632259193606;1482.644165400296;1503.624093976506;1518.9848101519065;992.0922356044139;997.800439912006;1012.5571061237707;1015.6902144845893;1017.3183966742153;5833.912491312633;5837.357890632027;5842.795502157404;5850.385709500526;5851.795187168429;6183.721732522047;6189.690515474208;6190.102435146879;6196.47329976957;6205.844853878689;5629.774809007676;5814.563907706939;5821.88356232873;5828.388019258002;5842.678652674059;3284.507323901434;3297.225152089257;3299.604047514266;3314.950275745866;3320.335932813447;6261.906071408933;6402.423781859562;6447.323031081669;6471.417572418411;6622.5695329804375;6405.583637063576;6436.710348034256;6439.420452159235;6492.188476440445;6507.609543427409;6268.874622507616;6429.45349645276;6484.319146489645;6531.542792004514;6552.868942621216;6245.28179259391;6249.25008998923;6282.994720844826;6301.243850737941;6340.809775706736;6185.84535386619;6193.876122477615;6222.533310001678;6235.719392627433;6272.466840318624;6176.752929882934;6501.349865013461;6530.00454652182;6565.967170164118;6595.175603049619;4258.169656916872;4268.381084742633;4280.250956082736;4285.828566857291;4305.913881722286;6220.2303094321105;6313.842153946188;6320.462760665395;6334.936650633619;6345.270293916259;6125.418085281891;6129.570930034854;6143.662098584442;6145.0782382642965;6159.5072394209255;6110.083487476736;6132.846678833065;6137.110119032626;6153.323134455296;6172.197614310111;5646.854195405719;5931.406859314034;5936.643801371932;5940.910886336622;5955.255593050869;6116.510679145568;6140.723667434887;6143.96928015357;6147.538934580014;6148.262208535004;5736.139579063174;6014.879702406015;6039.4262545058145;6039.879202416015;6052.334243233153 05:26:59 INFO - PROCESS | 6392 | |5;yui.html;698.9755358562452;700.5936556797059;716.0798374089289;861.7931696392866;888.9599968001439;13942.721145577083;14194.148351098942;14703.117812931232;14846;14862.925685371558;13465.730685386286;13765.58703238902;13964.301784910765;13980.860191398084;13988.650283742885;660.0791895306045;817.2726273616456;832.4422636833322;851.5274022917279;858.1289990659485;835.3567752830317;836.9665213391457;837.3134030095324;838.8070743728915;843.0768308701962;882.4528792148876;883.196291374849;884.1777147253052;885.3935054487664;892.1881088209731;686.413116785149;837.0499483086679;867.189178118455;868.3834477520936;869.656485688156;637.5154882289447;638.3393188050392;638.594492497263;641.355437785023;644.053241734654;12321.445534950948;12346.876531234753;12369.876301236962;12456.252624842538;12736.299503527302;12701.301428421526;13220.735585288241;13526.526571569948;13536.255505947169;13652.044356895021;10780.946095269552;10785.892141078568;10804.405757683324;11108.333499990027;11252.0998320135;3900.902477438058;3918.431827385013;3942;3942.2706799242233;4013.538443079054;54853.45146548523;54957;55002.049815516795;55416;55727;9946.751331216778;10487.423191724376;10502.527386267637;10539.10417614496;10826.296290741077;18910.432687019136;18980.43058708241;19000.809991899903;19010.42968710941;19366.903165484084;7627;7757.883631745528;8286.41995060352;8503.957480212559;8515.446495977865;4386.166628340605;4603.286490593963;4628;4739.146953548326;4743.075100355467;3123.531470279431;3171.5242713593148;3177.269228077509;3179.7933134346194;3191.872325107016;516.6590050566608;569.5955871331319;601.4586871815313;616.2266355723539;616.3651439017818;717.7380256206447;728.0197861815852;728.4354625165433;731.2833423245249;742.6212631557836;8261.934516370908;8710.346723995726;8826.77933051666;8980.146886045815;9180.770480738034;628.5003422279299;664.8936170212743;702.3257672634226;725.6553137259865;736.5212611802265;4261.2542805009;4302.806373713191;4365.4979677337515;4371.312141813236;4473.329000649928;50882.74558627257;53148;66221.33778662152;66389.66805165944;66690;44071;46031.5396846034;46239;50146.24780628293;50472;35607;36077.819610902305;41362.379564307164;44238.11523769506;45973.54026459759;8421.578921054046;8546.529940853312;8675.86986195195;8747.264606253022;8955.686550970684;30077;30547.54178687277;30762.846185769824;30847.537286941162;31241.218969525944;31963.36073278568;35379.82310088433;35473.645263547034;38642.42036369513;43638.12723745571;11524.94237528807;11567.595134170264;11607.76784464289;11697.649070527897;11723.296602203895;13094.803577946528;13311.80032299497;13321.200727956353;13530.594082177551;14139.222342771247;12518.93740531328;12883.355832208164;12901.741965160456;13110.868891310965;13542.255175965416;11334.036606888507;11696.88303116958;11765.647030589096;11863.228890122115;11962.96037319326;12703;12749.235045897276;12857.678558036125;12928.741425171256;12949.54676586315;10659.840102398626;10678.57285708563;10902.890971090188;11107.888921111009;11196.160287978271;10646;10858.891411085788;10884.673459796219;10931.781364372828;11089 05:26:59 INFO - PROCESS | 6392 | __end_tp_report 05:26:59 INFO - PROCESS | 6392 | __start_cc_report 05:26:59 INFO - PROCESS | 6392 | _x_x_mozilla_cycle_collect,826 05:26:59 INFO - PROCESS | 6392 | __end_cc_report 05:26:59 INFO - PROCESS | 6392 | __startTimestamp1460723219892__endTimestamp 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | ------- Summary: start ------- 05:26:59 INFO - PROCESS | 6392 | Number of tests: 6 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | [#0] dojo.html Cycles:165 Average:5255.05 Median:5458.18 stddev:578.07 (10.6%) stddev-sans-first:554.07 05:26:59 INFO - PROCESS | 6392 | Values: 3079.0 3107.2 3148.9 3154.1 3178.3 5252.1 5266.8 5291.2 5297.9 5365.8 5286.7 5307.2 5331.4 5362.6 5403.2 4796.4 4800.4 4813.1 4860.7 4965.6 4923.2 4939.0 4944.9 5000.7 5011.6 4781.9 4817.2 4818.1 4848.4 4905.7 4872.3 4872.6 4885.0 4887.8 4914.6 4730.5 4844.2 4864.2 4870.1 4897.1 5181.8 5222.3 5248.7 5286.6 5296.9 5464.4 5490.9 5491.1 5496.3 5511.9 5555.9 5561.3 5565.6 5580.4 5631.2 5326.3 5347.5 5363.1 5390.7 5396.6 5801.5 5818.7 5819.2 5821.6 5822.9 5475.6 5477.0 5560.2 5585.7 5610.7 5576.4 5578.1 5581.2 5582.6 5614.1 5555.1 5558.2 5560.8 5562.3 5564.7 5439.5 5608.2 5712.7 5759.9 5810.7 4295.6 4305.8 4307.8 4311.7 4342.0 3829.5 3879.5 3893.6 3905.8 3911.1 5273.4 5297.4 5365.2 5369.0 5378.9 5714.1 5729.3 5730.5 5746.5 5760.5 5355.3 5381.3 5429.7 5430.9 5474.2 4676.9 4760.0 4786.6 4829.0 4838.0 5854.4 5897.0 5897.2 5900.3 5907.4 5564.4 5659.0 5673.5 5682.1 5685.8 5879.7 5903.3 5909.7 5924.9 5941.4 5458.2 5475.5 5475.7 5477.2 5480.9 5475.9 5521.5 5548.1 5549.7 5551.3 5520.1 5564.8 5566.9 5572.5 5609.8 5479.9 5543.8 5562.1 5564.9 5566.8 5256.8 5322.7 5336.6 5393.7 5453.8 5575.6 5578.4 5582.1 5588.8 5604.4 5427.5 5452.8 5460.3 5463.9 5465.2 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | [#1] ext.html Cycles:180 Average:53179.56 Median:34335.57 stddev:98875.72 (288.0%) stddev-sans-first:99074.34 05:26:59 INFO - PROCESS | 6392 | Values: 620.1 644.1 670.8 673.4 676.8 29789.4 37397.6 38089.2 38108.0 38311.8 40747.0 41605.4 41656.0 41687.4 41793.8 7865.2 8481.9 8717.4 8736.1 10090.8 10152.3 10348.8 10348.9 10352.7 10353.3 10299.1 10395.6 10398.2 10404.1 10413.9 7845.3 8037.7 10282.3 10340.4 10713.4 10195.8 10351.0 10356.6 10358.4 10361.5 37986.6 38551.0 38666.0 38680.6 38768.2 3525.5 3553.5 3800.7 3922.2 3981.8 31021.7 31237.2 31330.2 31375.7 31703.4 4140.7 4344.2 4397.1 4448.7 4459.0 275887.0 277281.0 278463.0 278496.0 279300.0 56449.0 56509.4 57087.1 57111.4 57125.7 62969.7 65440.7 65691.7 65854.3 65883.3 16719.2 17013.0 17015.7 17035.2 17038.4 13273.7 13315.6 13367.0 13370.9 13378.4 18739.1 18886.4 18977.3 19566.0 19710.2 7168.0 7249.3 7311.2 7405.9 7408.5 895.4 969.2 1042.6 1135.5 1154.5 27025.5 28315.8 31022.8 31316.7 31443.8 1149.9 1182.9 1197.4 1204.6 1214.1 16793.8 16817.8 16821.6 16851.3 16927.3 427967.0 435169.0 437346.0 437671.0 439092.0 54053.7 55805.7 55842.4 55906.4 55925.0 1399.4 1399.4 1416.9 1417.3 1445.0 29586.0 30355.0 30362.7 30597.5 30795.5 48289.0 49045.5 49057.3 49095.5 49100.3 386873.0 393071.0 394393.0 394986.0 396619.0 25119.2 27084.2 27343.7 27431.9 28066.9 39895.0 40295.0 40535.8 41193.0 41569.8 34011.5 34315.5 34327.8 34343.3 35200.5 37797.4 38042.6 38110.6 38411.6 38472.8 40216.8 40276.4 41339.4 41594.0 41734.4 30446.2 31648.4 31813.5 31879.2 31993.7 25105.0 25413.6 25480.4 25508.0 25673.5 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | [#2] jquery.html Cycles:180 Average:26108.04 Median:12824.59 stddev:67447.25 (525.9%) stddev-sans-first:67608.81 05:26:59 INFO - PROCESS | 6392 | Values: 385.2 397.0 398.2 399.0 400.2 17710.7 17916.0 18423.5 18443.9 20379.1 18459.9 19236.3 19252.0 19388.2 19549.8 5601.9 5690.1 5766.9 5849.1 5885.6 5769.8 5774.9 5775.4 5786.4 5797.2 5499.3 5671.9 5681.1 5753.4 5756.2 5683.2 5700.8 5702.7 5718.7 5743.1 4865.0 5156.2 5161.2 5164.9 5175.5 22405.3 22412.8 22454.0 23189.4 23291.2 2358.0 2427.9 2456.6 2524.9 2694.2 14079.7 14336.0 14354.4 14752.5 14801.5 1905.2 1957.1 1962.3 2004.3 2059.5 58471.7 70951.0 73725.6 79709.6 81631.2 8641.7 9699.3 9819.5 10213.4 10800.5 14984.9 15030.5 15195.0 15230.7 15767.1 8019.0 8050.1 8123.3 8314.3 8322.2 7196.7 7445.0 7586.6 7635.4 7954.6 4654.3 4720.2 4733.7 4749.8 4804.5 1951.4 2014.9 2018.9 2043.4 2056.4 931.9 1039.4 1054.2 1092.6 1102.8 18217.4 18363.5 18975.1 19396.0 19563.7 1018.3 1030.6 1034.8 1046.8 1088.2 10317.8 10955.8 10965.2 10994.8 11022.9 372257.0 376668.0 394739.0 442952.0 445372.0 87814.6 88916.0 89357.1 89576.0 90035.1 1019.2 1048.1 1049.8 1096.1 1111.6 17289.1 17294.5 17348.9 17476.2 17486.7 36578.5 37369.0 38146.2 38636.6 42646.6 50564.0 52158.0 52287.5 52579.2 52852.2 8331.2 8342.1 8348.8 8351.4 8567.1 12154.5 12527.7 12785.7 12819.2 12831.8 10940.5 11340.9 11382.9 11410.5 11474.8 10973.7 11048.6 11119.4 11149.3 11478.8 11189.6 11195.3 11289.1 11563.9 11815.8 8372.4 8429.4 8501.5 8522.6 8648.5 11555.0 11567.5 11627.5 11642.5 11648.8 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | [#3] mootools.html Cycles:180 Average:5517.79 Median:5006.62 stddev:3092.39 (61.8%) stddev-sans-first:3085.34 05:26:59 INFO - PROCESS | 6392 | Values: 1368.3 1515.6 1573.9 1724.5 1875.0 8054.3 8406.6 8411.5 8415.8 8432.5 8131.5 8331.5 8347.1 8354.2 8355.7 1937.6 2136.6 2169.6 2209.1 2217.5 2259.3 2264.1 2269.1 2280.8 2282.6 2129.4 2184.5 2184.7 2189.4 2189.6 1918.8 2120.2 2183.6 2184.5 2184.5 2105.3 2114.9 2124.1 2127.6 2133.9 7944.2 8068.0 8071.0 8072.2 8078.2 4811.6 4960.3 5000.9 5012.3 5069.3 3106.2 3110.5 3169.7 3180.2 3195.2 1008.9 1058.6 1064.8 1070.9 1071.7 11719.6 11729.5 11734.1 11741.8 11745.7 4304.7 4367.5 4480.1 4488.5 4504.4 9755.3 9858.8 9877.4 9890.3 9937.3 4624.0 5097.4 5115.9 5120.5 5131.3 4570.0 4644.6 4660.2 4660.4 4672.6 3730.1 3757.3 3822.6 3830.0 3850.2 1235.9 1239.6 1252.9 1253.7 1259.3 827.2 949.4 960.7 997.4 1016.3 5811.6 5836.0 5857.9 5910.6 6025.2 1022.9 1097.2 1099.9 1111.1 1125.4 3865.0 3969.2 3973.1 3980.8 4007.9 9928.4 10340.6 10383.0 10407.4 10417.4 10015.9 10043.8 10082.9 10400.8 10570.0 7434.4 7458.2 7494.7 7523.9 7633.9 5560.4 5646.1 5744.8 5823.4 5841.6 9189.2 9261.5 9365.4 9370.6 9378.8 8903.5 9115.9 9519.5 9631.4 9667.1 6988.0 7319.7 7385.8 7498.8 7550.3 8230.7 8255.0 8282.5 8325.7 8326.0 7341.9 7569.9 7644.8 7683.5 7735.3 7202.5 7481.4 7551.0 7634.7 7639.4 6317.2 6317.4 6356.7 6357.6 6368.0 5030.6 5132.1 5201.7 5266.7 5267.9 4960.3 4978.6 5025.0 5071.9 5115.9 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | [#4] prototype.html Cycles:180 Average:5087.99 Median:5835.64 stddev:1536.53 (26.3%) stddev-sans-first:1498.82 05:26:59 INFO - PROCESS | 6392 | Values: 332.9 333.7 340.5 346.0 351.1 5762.6 5840.2 5848.9 5874.0 5891.1 5398.8 5561.4 5734.4 5757.0 5790.6 4435.4 4458.5 4466.3 4471.4 4487.5 4467.5 4481.5 4481.8 4482.0 4494.5 4120.6 4261.2 4405.0 4408.3 4419.8 4379.2 4379.8 4385.3 4400.9 4418.4 3910.7 3919.9 3922.1 3926.0 3939.4 5296.8 5537.3 5560.8 5586.1 5595.4 5061.4 5065.1 5076.1 5092.1 5102.3 5895.6 6066.2 6067.4 6076.5 6079.4 4176.2 4193.1 4198.0 4198.3 4209.3 6256.2 6333.3 6336.6 6358.4 6381.2 4060.8 4280.0 4302.8 4303.1 4311.8 4396.9 4424.4 4427.2 4432.4 4441.3 4973.3 5001.5 5025.8 5068.7 5080.4 5962.3 6057.1 6094.3 6117.3 6127.1 1429.6 1471.0 1482.6 1503.6 1519.0 992.1 997.8 1012.6 1015.7 1017.3 5833.9 5837.4 5842.8 5850.4 5851.8 6183.7 6189.7 6190.1 6196.5 6205.8 5629.8 5814.6 5821.9 5828.4 5842.7 3284.5 3297.2 3299.6 3315.0 3320.3 6261.9 6402.4 6447.3 6471.4 6622.6 6405.6 6436.7 6439.4 6492.2 6507.6 6268.9 6429.5 6484.3 6531.5 6552.9 6245.3 6249.3 6283.0 6301.2 6340.8 6185.8 6193.9 6222.5 6235.7 6272.5 6176.8 6501.3 6530.0 6566.0 6595.2 4258.2 4268.4 4280.3 4285.8 4305.9 6220.2 6313.8 6320.5 6334.9 6345.3 6125.4 6129.6 6143.7 6145.1 6159.5 6110.1 6132.8 6137.1 6153.3 6172.2 5646.9 5931.4 5936.6 5940.9 5955.3 6116.5 6140.7 6144.0 6147.5 6148.3 5736.1 6014.9 6039.4 6039.9 6052.3 05:26:59 INFO - PROCESS | 6392 | 05:26:59 INFO - PROCESS | 6392 | [#5] yui.html Cycles:180 Average:13863.88 Median:22811.82 stddev:15634.69 (68.5%) stddev-sans-first:15647.29 05:26:59 INFO - PROCESS | 6392 | Values: 699.0 700.6 716.1 861.8 889.0 13942.7 14194.1 14703.1 14846.0 14862.9 13465.7 13765.6 13964.3 13980.9 13988.7 660.1 817.3 832.4 851.5 858.1 835.4 837.0 837.3 838.8 843.1 882.5 883.2 884.2 885.4 892.2 686.4 837.0 867.2 868.4 869.7 637.5 638.3 638.6 641.4 644.1 12321.4 12346.9 12369.9 12456.3 12736.3 12701.3 13220.7 13526.5 13536.3 13652.0 10780.9 10785.9 10804.4 11108.3 11252.1 3900.9 3918.4 3942.0 3942.3 4013.5 54853.5 54957.0 55002.0 55416.0 55727.0 9946.8 10487.4 10502.5 10539.1 10826.3 18910.4 18980.4 19000.8 19010.4 19366.9 7627.0 7757.9 8286.4 8504.0 8515.4 4386.2 4603.3 4628.0 4739.1 4743.1 3123.5 3171.5 3177.3 3179.8 3191.9 516.7 569.6 601.5 616.2 616.4 717.7 728.0 728.4 731.3 742.6 8261.9 8710.3 8826.8 8980.1 9180.8 628.5 664.9 702.3 725.7 736.5 4261.3 4302.8 4365.5 4371.3 4473.3 50882.7 53148.0 66221.3 66389.7 66690.0 44071.0 46031.5 46239.0 50146.2 50472.0 35607.0 36077.8 41362.4 44238.1 45973.5 8421.6 8546.5 8675.9 8747.3 8955.7 30077.0 30547.5 30762.8 30847.5 31241.2 31963.4 35379.8 35473.6 38642.4 43638.1 11524.9 11567.6 11607.8 11697.6 11723.3 13094.8 13311.8 13321.2 13530.6 14139.2 12518.9 12883.4 12901.7 13110.9 13542.3 11334.0 11696.9 11765.6 11863.2 11963.0 12703.0 12749.2 12857.7 12928.7 12949.5 10659.8 10678.6 10902.9 11107.9 11196.2 10646.0 10858.9 10884.7 10931.8 11089.0 05:26:59 INFO - PROCESS | 6392 | -------- Summary: end -------- 05:26:59 INFO - PROCESS | 6392 | 05:27:00 INFO - TEST-INFO | 6392: exit 0 05:27:00 INFO - TEST-OK | dromaeo_css | took 1111327ms 05:27:00 INFO - TEST-START | kraken 05:27:00 INFO - operating with platform_type : linux_ 05:27:00 INFO - Initialising browser for kraken test... 05:27:00 INFO - TEST-INFO | started process 6583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkixuFs/profile http://localhost:37140/getInfo.html) 05:27:04 INFO - PROCESS | 6583 | __metrics Screen width/height:1600/1200 05:27:04 INFO - PROCESS | 6583 | colorDepth:24 05:27:04 INFO - PROCESS | 6583 | Browser inner width/height: 1024/697 05:27:04 INFO - PROCESS | 6583 | __metrics 05:27:05 ERROR - PROCESS | 6583 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:27:06 INFO - TEST-INFO | 6583: exit 0 05:27:06 INFO - Browser initialized. 05:27:06 INFO - Running cycle 1/1 for kraken test... 05:27:06 INFO - TEST-INFO | started process 6662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkixuFs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:18 INFO - PROCESS | 6662 | RSS: Main: 153329664 05:27:18 INFO - PROCESS | 6662 | 05:27:20 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:21 INFO - PROCESS | 6662 | RSS: Main: 208105472 05:27:21 INFO - PROCESS | 6662 | 05:27:24 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-dft) 05:27:24 INFO - PROCESS | 6662 | RSS: Main: 194715648 05:27:24 INFO - PROCESS | 6662 | 05:27:27 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-fft) 05:27:28 INFO - PROCESS | 6662 | RSS: Main: 264077312 05:27:28 INFO - PROCESS | 6662 | 05:27:30 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-oscillator) 05:27:31 INFO - PROCESS | 6662 | RSS: Main: 172724224 05:27:31 INFO - PROCESS | 6662 | 05:27:33 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:33 INFO - PROCESS | 6662 | RSS: Main: 177225728 05:27:33 INFO - PROCESS | 6662 | 05:27:36 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37140/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:37 INFO - PROCESS | 6662 | RSS: Main: 213606400 05:27:37 INFO - PROCESS | 6662 | 05:27:40 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37140/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:41 INFO - PROCESS | 6662 | RSS: Main: 213770240 05:27:41 INFO - PROCESS | 6662 | 05:27:44 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37140/tests/kraken/driver.html?testName=json-parse-financial) 05:27:44 INFO - PROCESS | 6662 | RSS: Main: 213762048 05:27:44 INFO - PROCESS | 6662 | 05:27:46 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:46 INFO - PROCESS | 6662 | RSS: Main: 201830400 05:27:46 INFO - PROCESS | 6662 | 05:27:48 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:49 INFO - PROCESS | 6662 | RSS: Main: 205066240 05:27:49 INFO - PROCESS | 6662 | 05:27:51 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:52 INFO - PROCESS | 6662 | RSS: Main: 217231360 05:27:52 INFO - PROCESS | 6662 | 05:27:54 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:55 INFO - PROCESS | 6662 | RSS: Main: 223096832 05:27:55 INFO - PROCESS | 6662 | 05:27:58 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:58 INFO - PROCESS | 6662 | RSS: Main: 219193344 05:27:58 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37140/tests/kraken/driver.html?testName=ai-astar) 05:28:00 INFO - PROCESS | 6662 | RSS: Main: 282730496 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | __start_tp_report 05:28:00 INFO - PROCESS | 6662 | _x_x_mozilla_page_load 05:28:00 INFO - PROCESS | 6662 | _x_x_mozilla_page_load_details 05:28:00 INFO - PROCESS | 6662 | |i|pagename|runs| 05:28:00 INFO - PROCESS | 6662 | |0;ai-astar;110;112;108;110;112;111;99;111;111;111 05:28:00 INFO - PROCESS | 6662 | |1;audio-beat-detection;164;128;160;195;128;154;154;130;181;129 05:28:00 INFO - PROCESS | 6662 | |2;audio-dft;162;161;160;161;162;161;168;163;161;163 05:28:00 INFO - PROCESS | 6662 | |3;audio-fft;76;72;116;112;73;71;75;137;106;72 05:28:00 INFO - PROCESS | 6662 | |4;audio-oscillator;93;93;148;92;93;93;148;93;93;153 05:28:00 INFO - PROCESS | 6662 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;118 05:28:00 INFO - PROCESS | 6662 | |6;imaging-darkroom;145;146;145;145;146;145;146;146;145;146 05:28:00 INFO - PROCESS | 6662 | |7;imaging-desaturate;97;96;96;96;96;97;96;95;95;95 05:28:00 INFO - PROCESS | 6662 | |8;json-parse-financial;57;57;57;58;67;57;57;75;55;54 05:28:00 INFO - PROCESS | 6662 | |9;json-stringify-tinderbox;60;61;61;60;61;60;61;61;61;62 05:28:00 INFO - PROCESS | 6662 | |10;stanford-crypto-aes;80;80;81;86;81;81;90;82;81;81 05:28:00 INFO - PROCESS | 6662 | |11;stanford-crypto-ccm;129;129;130;127;135;136;130;128;161;138 05:28:00 INFO - PROCESS | 6662 | |12;stanford-crypto-pbkdf2;164;166;165;163;169;172;165;165;165;168 05:28:00 INFO - PROCESS | 6662 | |13;stanford-crypto-sha256-iterative;69;68;69;68;70;66;67;68;67;67 05:28:00 INFO - PROCESS | 6662 | __end_tp_report 05:28:00 INFO - PROCESS | 6662 | __start_cc_report 05:28:00 INFO - PROCESS | 6662 | _x_x_mozilla_cycle_collect,1585 05:28:00 INFO - PROCESS | 6662 | __end_cc_report 05:28:00 INFO - PROCESS | 6662 | __startTimestamp1460723280568__endTimestamp 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | ------- Summary: start ------- 05:28:00 INFO - PROCESS | 6662 | Number of tests: 14 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.87 (3.5%) stddev-sans-first:4.10 05:28:00 INFO - PROCESS | 6662 | Values: 110.0 112.0 108.0 110.0 112.0 111.0 99.0 111.0 111.0 111.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:157.00 stddev:23.73 (15.1%) stddev-sans-first:24.79 05:28:00 INFO - PROCESS | 6662 | Values: 164.0 128.0 160.0 195.0 128.0 154.0 154.0 130.0 181.0 129.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.25 (1.4%) stddev-sans-first:2.39 05:28:00 INFO - PROCESS | 6662 | Values: 162.0 161.0 160.0 161.0 162.0 161.0 168.0 163.0 161.0 163.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#3] audio-fft Cycles:10 Average:91.00 Median:72.00 stddev:24.34 (33.8%) stddev-sans-first:25.21 05:28:00 INFO - PROCESS | 6662 | Values: 76.0 72.0 116.0 112.0 73.0 71.0 75.0 137.0 106.0 72.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:93.00 stddev:27.48 (29.5%) stddev-sans-first:28.46 05:28:00 INFO - PROCESS | 6662 | Values: 93.0 93.0 148.0 92.0 93.0 93.0 148.0 93.0 93.0 153.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:28:00 INFO - PROCESS | 6662 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:28:00 INFO - PROCESS | 6662 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 05:28:00 INFO - PROCESS | 6662 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 95.0 95.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:57.00 stddev:6.50 (11.4%) stddev-sans-first:6.84 05:28:00 INFO - PROCESS | 6662 | Values: 57.0 57.0 57.0 58.0 67.0 57.0 57.0 75.0 55.0 54.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 05:28:00 INFO - PROCESS | 6662 | Values: 60.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 61.0 62.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:3.20 (3.9%) stddev-sans-first:3.28 05:28:00 INFO - PROCESS | 6662 | Values: 80.0 80.0 81.0 86.0 81.0 81.0 90.0 82.0 81.0 81.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#11] stanford-crypto-ccm Cycles:10 Average:134.30 Median:132.50 stddev:10.09 (7.6%) stddev-sans-first:10.52 05:28:00 INFO - PROCESS | 6662 | Values: 129.0 129.0 130.0 127.0 135.0 136.0 130.0 128.0 161.0 138.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:165.50 stddev:2.70 (1.6%) stddev-sans-first:2.74 05:28:00 INFO - PROCESS | 6662 | Values: 164.0 166.0 165.0 163.0 169.0 172.0 165.0 165.0 165.0 168.0 05:28:00 INFO - PROCESS | 6662 | 05:28:00 INFO - PROCESS | 6662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 05:28:00 INFO - PROCESS | 6662 | Values: 69.0 68.0 69.0 68.0 70.0 66.0 67.0 68.0 67.0 67.0 05:28:00 INFO - PROCESS | 6662 | -------- Summary: end -------- 05:28:00 INFO - PROCESS | 6662 | 05:28:01 INFO - TEST-INFO | 6662: exit 0 05:28:01 INFO - TEST-OK | kraken | took 60927ms 05:28:01 INFO - SUITE-END | took 1172s 05:28:01 INFO - Completed test suite (00:19:32) 05:28:01 INFO - javascript benchmark 05:28:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.045495896272, 3107.238726512005, 3148.9370212595736, 3154.1010811918595, 3178.316661917688, 5252.133397989332, 5266.789328426863, 5291.153415453528, 5297.920531192026, 5365.7585408656605, 5286.735663216833, 5307.150855863063, 5331.360236771593, 5362.597805164609, 5403.2165336026255, 4796.352492413532, 4800.42394912611, 4813.085513752393, 4860.684055536379, 4965.602751779849, 4923.236898280755, 4939.0, 4944.901101977958, 5000.674956127858, 5011.574016208627, 4781.880452988668, 4817.205161148407, 4818.132736107499, 4848.369711937443, 4905.73018483985, 4872.269159626085, 4872.56146946773, 4885.0, 4887.780049897763, 4914.582260507826, 4730.526947305242, 4844.249141383091, 4864.221724524059, 4870.123377791996, 4897.118518666639, 5181.766820493049, 5222.321098257202, 5248.685078895279, 5286.577073834084, 5296.867578310535, 5464.4262352452815, 5490.890182196334, 5491.121420572689, 5496.258005169331, 5511.944880551183, 5555.861103472405, 5561.277033985596, 5565.582581306418, 5580.414056524047, 5631.21163037171, 5326.307580014573, 5347.49198826107, 5363.06146424378, 5390.703511306877, 5396.568274538027, 5801.53587712982, 5818.738156782955, 5819.243498345188, 5821.563382746311, 5822.94177058224, 5475.589330800206, 5477.0, 5560.2493663355735, 5585.748641311151, 5610.663360198401, 5576.358718747315, 5578.135389014709, 5581.162825576196, 5582.609217354828, 5614.073677843192, 5555.138953462219, 5558.166275058774, 5560.805371811967, 5562.276904002454, 5564.749586268627, 5439.456054394529, 5608.242887210256, 5712.714364281853, 5759.94240057594, 5810.6513609183585, 4295.613394794484, 4305.784710764449, 4307.8492252771, 4311.741295522279, 4341.978290108593, 3829.483019792348, 3879.476270703475, 3893.6106389361403, 3905.804709764557, 3911.06134527717, 5273.367195936512, 5297.443768404262, 5365.222042803772, 5368.973155134199, 5378.892422151535, 5714.142878568248, 5729.255196824386, 5730.5129064030025, 5746.540276777848, 5760.53915686744, 5355.3305836770405, 5381.327334083239, 5429.67421954684, 5430.8913821723345, 5474.151506516497, 4676.906461870743, 4760.047990401933, 4786.593139583175, 4829.0, 4837.975810120997, 5854.414558544111, 5896.970515147397, 5897.174395584621, 5900.262467191601, 5907.409259074058, 5564.38791732901, 5658.999999999917, 5673.461021202979, 5682.147677848356, 5685.829425117253, 5879.7060146993335, 5903.321118071477, 5909.734061967136, 5924.940750592439, 5941.405859414197, 5458.181272809111, 5475.534579560782, 5475.67145971243, 5477.233187353694, 5480.890382192413, 5475.945240547543, 5521.475459831309, 5548.140038294071, 5549.722513874371, 5551.333839939233, 5520.1167813149705, 5564.805231817029, 5566.860828479321, 5572.526335261548, 5609.831705048855, 5479.945200547943, 5543.805966791143, 5562.11006239016, 5564.888702226014, 5566.777328906798, 5256.842294731164, 5322.707251101227, 5336.606345452565, 5393.730313484231, 5453.809116680897, 5575.581831362583, 5578.3584887738425, 5582.106862901916, 5588.804391846428, 5604.355499117653, 5427.48438898304, 5452.809151679672, 5460.262864513399, 5463.918041229305, 5465.180222966428], "value": 5217.422095113377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.0791824141149, 644.1111266452295, 670.8289386206517, 673.4376795375861, 676.7732809508815, 29789.404211915775, 37397.62602373975, 38089.23821523568, 38108.0, 38311.80844095779, 40747.0, 41605.375919361235, 41656.0, 41687.374689379605, 41793.7910310448, 7865.174156713549, 8481.91518084819, 8717.433366831136, 8736.126387361277, 10090.848637270446, 10152.34009789365, 10348.844767328495, 10348.896511034869, 10352.689419317432, 10353.275270731052, 10299.07308342249, 10395.636152734656, 10398.22013348998, 10404.115650169744, 10413.895861041407, 7845.2547008034435, 8037.718679846177, 10282.280240383176, 10340.379577225316, 10713.410762408064, 10195.796084078276, 10351.0, 10356.637517686844, 10358.378497290187, 10361.48192590375, 37986.620133798584, 38551.03622409434, 38666.0, 38680.61319386798, 38768.22463550713, 3525.541679581638, 3553.466979953002, 3800.657940785343, 3922.1959498303063, 3981.840726370942, 31021.689783102105, 31237.219069523217, 31330.21674458134, 31375.686243137505, 31703.365932681216, 4140.68944829136, 4344.1963236800975, 4397.098594788061, 4448.6885917985755, 4459.0, 275887.0, 277280.99999999796, 278463.0, 278496.0, 279300.0, 56449.0, 56509.434905650414, 57087.14369284464, 57111.42888571061, 57125.71437142871, 62969.685151574864, 65440.672796635714, 65691.67154164294, 65854.34145658482, 65883.34116658868, 16719.247633856507, 17013.0, 17015.744763828552, 17035.233414496128, 17038.403655871985, 13273.66815829612, 13315.600531984055, 13367.0, 13370.933145334406, 13378.397972091085, 18739.09544020679, 18886.43340699781, 18977.335793247446, 19566.0, 19710.211591536463, 7168.0, 7249.347558719741, 7311.195768465464, 7405.8889116663295, 7408.481406301615, 895.4448242089946, 969.1519920069939, 1042.598599539183, 1135.4833550734395, 1154.5151036564664, 27025.459490810073, 28315.82035814968, 31022.844885775427, 31316.686833131378, 31443.842780785948, 1149.8562679665042, 1182.8639706433871, 1197.3773637708516, 1204.5723768062387, 1214.0530386298701, 16793.832061679226, 16817.83182168187, 16821.57946051334, 16851.325946961984, 16927.322907083824, 427967.0, 435169.0, 437346.0, 437671.0, 439092.0, 54053.72973135109, 55805.7209713957, 55842.44157558454, 55906.44093559012, 55925.0, 1399.3702833724865, 1399.4472183487464, 1416.872481476672, 1417.2701058954647, 1445.0101680348994, 29586.0, 30355.0, 30362.696373035986, 30597.54103688491, 30795.53806692946, 48289.0, 49045.5095449041, 49057.26414103863, 49095.50904491052, 49100.26349604687, 386873.0, 393071.0, 394393.0, 394986.0, 396619.0, 25119.24642260735, 27084.187474375012, 27343.72656273412, 27431.86284068567, 28066.85966570154, 39895.0, 40295.0, 40535.797321013204, 41192.970175745846, 41569.79215103905, 34011.4898276531, 34315.4852677215, 34327.828360859035, 34343.31313373768, 35200.471992919614, 37797.43303850389, 38042.61957380391, 38110.618893811814, 38411.6158838408, 38472.80763596164, 40216.79891600523, 40276.3958540628, 41339.379909300784, 41594.0, 41734.37398439086, 30446.23884402819, 31648.367032658756, 31813.5227971576, 31879.20301992376, 31993.6800632, 25105.0, 25413.61879571845, 25480.362990925376, 25508.0, 25673.486530269663], "value": 19624.448767331487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2449199568846, 396.9940450893237, 398.2155154345937, 399.0, 400.17563818533824, 17710.73433898491, 17916.0, 18423.539411514703, 18443.90778046108, 20379.08294126768, 18459.907700461514, 19236.3267285645, 19252.0, 19388.22447102114, 19549.804501954975, 5601.943980560183, 5690.089585666305, 5766.913496297559, 5849.093390524476, 5885.61743486672, 5769.826905192851, 5774.913376299359, 5775.393583673716, 5786.363500014995, 5797.246357973458, 5499.257600223958, 5671.8582035449235, 5681.147827825838, 5753.367129615739, 5756.194132821408, 5683.204351390788, 5700.80283140541, 5702.743376548045, 5718.7426565804635, 5743.081107022877, 4864.975675121637, 5156.226566015091, 5161.200013997836, 5164.948350516522, 5175.456577059392, 22405.32784016482, 22412.767297798615, 22454.0, 23189.42026449352, 23291.18480853179, 2357.988210058939, 2427.927162185137, 2456.6437866509436, 2524.911628093026, 2694.2456112288396, 14079.718405631933, 14335.996480246387, 14354.425822967069, 14752.483663071742, 14801.481948131765, 1905.237904838062, 1957.0606109067728, 1962.3426152238874, 2004.258424382973, 2059.5263089489354, 58471.70764146152, 70951.0, 73725.6313718428, 79709.60145199294, 81631.18368816354, 8641.740747777576, 9699.272554558436, 9819.509024548886, 10213.438260895722, 10800.459977001276, 14984.850151498564, 15030.473933412279, 15195.0, 15230.695386092217, 15767.132807695687, 8018.959905200553, 8050.074241462306, 8123.309518690978, 8314.293285070837, 8322.20939010793, 7196.676149573177, 7444.962775186198, 7586.634405806897, 7635.350995165473, 7954.642041108048, 4654.2785868190485, 4720.197566413718, 4733.715977041388, 4749.810007599726, 4804.495527969582, 1951.3853136262032, 2014.8891810950245, 2018.9091490882652, 2043.4074118505466, 2056.4344805178694, 931.855562387831, 1039.449091981251, 1054.2304117993908, 1092.5738961804902, 1102.7573933734566, 18217.362392316205, 18363.540911477052, 18975.146118424705, 19396.0, 19563.706544401844, 1018.332991890313, 1030.577463240083, 1034.7775228325945, 1046.8325067989085, 1088.2491081153978, 10317.761868575819, 10955.780884382268, 10965.232433729563, 10994.780104398027, 11022.944885275523, 372257.0, 376668.0, 394739.0, 442952.0, 445372.0, 87814.56092719495, 88916.0, 89357.08536030451, 89576.0, 90035.09964900267, 1019.23557332001, 1048.0567489259574, 1049.7952899184738, 1096.13405409727, 1111.6387174168428, 17289.135543222535, 17294.481165565052, 17348.913255433643, 17476.213570389617, 17486.73769893427, 36578.45132322964, 37369.0, 38146.2370752589, 38636.61363386443, 42646.5735342655, 50564.0, 52158.0, 52287.47712522826, 52579.21131182959, 52852.207216892544, 8331.16688331162, 8342.08237093907, 8348.833023339621, 8351.415400921876, 8567.057623661516, 12154.453049612612, 12527.686807829512, 12785.680357991125, 12819.230846149261, 12831.807522886977, 10940.45297735126, 11340.94329528347, 11382.943085284853, 11410.486528106088, 11474.827877582009, 10973.670789876316, 11048.558057677603, 11119.388433636228, 11149.331040137618, 11478.770424591628, 11189.552417903193, 11195.328280303207, 11289.096872250037, 11563.884361156617, 11815.76368472643, 8372.41393102477, 8429.40994130405, 8501.532415717194, 8522.573871306535, 8648.481091134552, 11555.0, 11567.479463423997, 11627.476763545492, 11642.5342986283, 11648.825267620823], "value": 9125.01358149493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.322680273265, 1515.6286709756107, 1573.9370425182992, 1724.4654157211266, 1874.962500749985, 8054.315383192428, 8406.579671016456, 8411.495310281387, 8415.789605259872, 8432.53621050842, 8131.512109273448, 8331.500109993405, 8347.081820999685, 8354.206350396702, 8355.707550235744, 1937.5737337785665, 2136.572685462906, 2169.566086782642, 2209.0611490116717, 2217.4567231028423, 2259.288324177887, 2264.071730590458, 2269.103704036904, 2280.794728474437, 2282.6461898405773, 2129.4144110369616, 2184.453886528368, 2184.6613774864923, 2189.386971647941, 2189.6496560550313, 1918.8177123173346, 2120.162535798359, 2183.563287342522, 2184.530325979922, 2184.541246338271, 2105.2947262667026, 2114.851960362775, 2124.1184908263053, 2127.606392817334, 2133.903974321144, 7944.165862584461, 8067.959660201662, 8070.959645201737, 8072.19278072194, 8078.192180781874, 4811.59101476375, 4960.280759289919, 5000.924986125211, 5012.323336349583, 5069.315642388267, 3106.176863131272, 3110.5334199869976, 3169.7464202863716, 3180.236743181643, 3195.2171717929023, 1008.8587597736323, 1058.6188971970084, 1064.8402739589123, 1070.946452677363, 1071.7427817323864, 11719.589814356541, 11729.53081876724, 11734.119941004545, 11741.765164696744, 11745.706357341049, 4304.698671092993, 4367.45406824147, 4480.059187570647, 4488.4613846338, 4504.3919070925, 9755.317127801127, 9858.753531161778, 9877.357971731815, 9890.307678462583, 9937.254705897087, 4623.976880115578, 5097.362829646294, 5115.923261151086, 5120.539151476385, 5131.307273518102, 4570.0, 4644.558766917137, 4660.184467718136, 4660.440747110369, 4672.556107169813, 3730.0861288984374, 3757.323681737259, 3822.5604055533413, 3829.9617003830163, 3850.172212974224, 1235.882591153839, 1239.6116349688407, 1252.874712528758, 1253.6677780388204, 1259.3136740476461, 827.2430725885868, 949.4066208619613, 960.6829746183743, 997.3517213810936, 1016.339379403379, 5811.622244554091, 5836.0, 5857.941420585739, 5910.615809972338, 6025.216721826135, 1022.9130523905402, 1097.2100087936674, 1099.9065079468176, 1111.1222034761229, 1125.3754166437543, 3865.033741564609, 3969.186316805048, 3973.145773658677, 3980.8208630611693, 4007.859724909614, 9928.404295742279, 10340.638077667245, 10383.0, 10407.375557466576, 10417.427041512638, 10015.949920250352, 10043.849342259871, 10082.899171008343, 10400.791984160425, 10570.0, 7434.442416818652, 7458.216887226763, 7494.737684181027, 7523.887141692879, 7633.923660763321, 5560.388357280615, 5646.06839871433, 5744.798932037359, 5823.388544202798, 5841.649501029782, 9189.218916391914, 9261.53692315368, 9365.391249568756, 9370.625174993196, 9378.765530861783, 8903.465792052497, 9115.908840911507, 9519.524023798644, 9631.373960692532, 9667.129958303787, 6988.0, 7319.74380896666, 7385.8153546161775, 7498.775036748906, 7550.282723141293, 8230.711925082593, 8255.009398872175, 8282.50304981703, 8325.708600198965, 8326.04250511199, 7341.853162936818, 7569.886451703339, 7644.80887977805, 7683.538987660758, 7735.303822655988, 7202.459815513753, 7481.364084052916, 7551.0, 7634.656440460081, 7639.388848891964, 6317.241930968129, 6317.399847014526, 6356.682165891594, 6357.618542887441, 6368.0, 5030.647854650139, 5132.127538318569, 5201.739913004259, 5266.683998960075, 5267.868303292448, 4960.330355402119, 4978.576820970114, 5025.0, 5071.873203169803, 5115.897682046264], "value": 4449.536993282056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.91469808424534, 333.7180082830009, 340.4994657852957, 345.9619441861395, 351.07841914973193, 5762.567807414445, 5840.211571437854, 5848.941510584893, 5874.001419758641, 5891.145783861343, 5398.757055932482, 5561.360443548993, 5734.423033665744, 5757.0, 5790.623609465381, 4435.356873253392, 4458.4872739634875, 4466.33005049242, 4471.441069866267, 4487.483939346984, 4467.53090925453, 4481.529439408864, 4481.753503557303, 4481.977590112061, 4494.505604383515, 4120.58794120587, 4261.190373828963, 4404.955950440502, 4408.338749187616, 4419.845305414311, 4379.1679580879845, 4379.802908869076, 4385.342198670193, 4400.867973960786, 4418.359337895987, 3910.7066969977363, 3919.9216015679526, 3922.1371298314325, 3925.9803700981597, 3939.3697008478794, 5296.788128474856, 5537.335519737617, 5560.833175004756, 5586.078297081018, 5595.356533998602, 5061.44324124346, 5065.088284108859, 5076.06092872816, 5092.10888094582, 5102.260172275, 5895.555588880752, 6066.241719785027, 6067.393260673942, 6076.513878889678, 6079.39206079393, 4176.164767046573, 4193.098483825962, 4198.0, 4198.286291330481, 4209.34755112958, 6256.1866957295715, 6333.271673757485, 6336.619802811846, 6358.395952384516, 6381.234251889803, 4060.796960151981, 4279.957200427956, 4302.849400271038, 4303.07483890965, 4311.8490852820005, 4396.912061758747, 4424.424824772759, 4427.203103441411, 4432.445944256968, 4441.333799930037, 4973.254011898244, 5001.474845141208, 5025.773840177201, 5068.695878247317, 5080.441151473335, 5962.314333851663, 6057.121717350959, 6094.329623741385, 6117.265928088658, 6127.111568822585, 1429.6425893526618, 1470.9632259193606, 1482.644165400296, 1503.624093976506, 1518.9848101519065, 992.0922356044139, 997.800439912006, 1012.5571061237707, 1015.6902144845893, 1017.3183966742153, 5833.912491312633, 5837.357890632027, 5842.795502157404, 5850.385709500526, 5851.795187168429, 6183.721732522047, 6189.690515474208, 6190.102435146879, 6196.47329976957, 6205.844853878689, 5629.774809007676, 5814.563907706939, 5821.88356232873, 5828.388019258002, 5842.678652674059, 3284.507323901434, 3297.225152089257, 3299.604047514266, 3314.950275745866, 3320.335932813447, 6261.906071408933, 6402.423781859562, 6447.323031081669, 6471.417572418411, 6622.5695329804375, 6405.583637063576, 6436.710348034256, 6439.420452159235, 6492.188476440445, 6507.609543427409, 6268.874622507616, 6429.45349645276, 6484.319146489645, 6531.542792004514, 6552.868942621216, 6245.28179259391, 6249.25008998923, 6282.994720844826, 6301.243850737941, 6340.809775706736, 6185.84535386619, 6193.876122477615, 6222.533310001678, 6235.719392627433, 6272.466840318624, 6176.752929882934, 6501.349865013461, 6530.00454652182, 6565.967170164118, 6595.175603049619, 4258.169656916872, 4268.381084742633, 4280.250956082736, 4285.828566857291, 4305.913881722286, 6220.2303094321105, 6313.842153946188, 6320.462760665395, 6334.936650633619, 6345.270293916259, 6125.418085281891, 6129.570930034854, 6143.662098584442, 6145.0782382642965, 6159.5072394209255, 6110.083487476736, 6132.846678833065, 6137.110119032626, 6153.323134455296, 6172.197614310111, 5646.854195405719, 5931.406859314034, 5936.643801371932, 5940.910886336622, 5955.255593050869, 6116.510679145568, 6140.723667434887, 6143.96928015357, 6147.538934580014, 6148.262208535004, 5736.139579063174, 6014.879702406015, 6039.4262545058145, 6039.879202416015, 6052.334243233153], "value": 4589.972236434149, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.9755358562452, 700.5936556797059, 716.0798374089289, 861.7931696392866, 888.9599968001439, 13942.721145577083, 14194.148351098942, 14703.117812931232, 14846.0, 14862.925685371558, 13465.730685386286, 13765.58703238902, 13964.301784910765, 13980.860191398084, 13988.650283742885, 660.0791895306045, 817.2726273616456, 832.4422636833322, 851.5274022917279, 858.1289990659485, 835.3567752830317, 836.9665213391457, 837.3134030095324, 838.8070743728915, 843.0768308701962, 882.4528792148876, 883.196291374849, 884.1777147253052, 885.3935054487664, 892.1881088209731, 686.413116785149, 837.0499483086679, 867.189178118455, 868.3834477520936, 869.656485688156, 637.5154882289447, 638.3393188050392, 638.594492497263, 641.355437785023, 644.053241734654, 12321.445534950948, 12346.876531234753, 12369.876301236962, 12456.252624842538, 12736.299503527302, 12701.301428421526, 13220.735585288241, 13526.526571569948, 13536.255505947169, 13652.044356895021, 10780.946095269552, 10785.892141078568, 10804.405757683324, 11108.333499990027, 11252.0998320135, 3900.902477438058, 3918.431827385013, 3942.0, 3942.2706799242233, 4013.538443079054, 54853.45146548523, 54957.0, 55002.049815516795, 55416.0, 55727.0, 9946.751331216778, 10487.423191724376, 10502.527386267637, 10539.10417614496, 10826.296290741077, 18910.432687019136, 18980.43058708241, 19000.809991899903, 19010.42968710941, 19366.903165484084, 7627.0, 7757.883631745528, 8286.41995060352, 8503.957480212559, 8515.446495977865, 4386.166628340605, 4603.286490593963, 4628.0, 4739.146953548326, 4743.075100355467, 3123.531470279431, 3171.5242713593148, 3177.269228077509, 3179.7933134346194, 3191.872325107016, 516.6590050566608, 569.5955871331319, 601.4586871815313, 616.2266355723539, 616.3651439017818, 717.7380256206447, 728.0197861815852, 728.4354625165433, 731.2833423245249, 742.6212631557836, 8261.934516370908, 8710.346723995726, 8826.77933051666, 8980.146886045815, 9180.770480738034, 628.5003422279299, 664.8936170212743, 702.3257672634226, 725.6553137259865, 736.5212611802265, 4261.2542805009, 4302.806373713191, 4365.4979677337515, 4371.312141813236, 4473.329000649928, 50882.74558627257, 53148.0, 66221.33778662152, 66389.66805165944, 66690.0, 44071.0, 46031.5396846034, 46239.0, 50146.24780628293, 50472.0, 35607.0, 36077.819610902305, 41362.379564307164, 44238.11523769506, 45973.54026459759, 8421.578921054046, 8546.529940853312, 8675.86986195195, 8747.264606253022, 8955.686550970684, 30077.0, 30547.54178687277, 30762.846185769824, 30847.537286941162, 31241.218969525944, 31963.36073278568, 35379.82310088433, 35473.645263547034, 38642.42036369513, 43638.12723745571, 11524.94237528807, 11567.595134170264, 11607.76784464289, 11697.649070527897, 11723.296602203895, 13094.803577946528, 13311.80032299497, 13321.200727956353, 13530.594082177551, 14139.222342771247, 12518.93740531328, 12883.355832208164, 12901.741965160456, 13110.868891310965, 13542.255175965416, 11334.036606888507, 11696.88303116958, 11765.647030589096, 11863.228890122115, 11962.96037319326, 12703.0, 12749.235045897276, 12857.678558036125, 12928.741425171256, 12949.54676586315, 10659.840102398626, 10678.57285708563, 10902.890971090188, 11107.888921111009, 11196.160287978271, 10646.0, 10858.891411085788, 10884.673459796219, 10931.781364372828, 11089.0], "value": 6531.5371342828885, "unit": "score"}], "name": "dromaeo_css", "value": 7067.7042816833955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 108.0, 110.0, 112.0, 111.0, 99.0, 111.0, 111.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 128.0, 160.0, 195.0, 128.0, 154.0, 154.0, 130.0, 181.0, 129.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 162.0, 161.0, 168.0, 163.0, 161.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 116.0, 112.0, 73.0, 71.0, 75.0, 137.0, 106.0, 72.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 148.0, 92.0, 93.0, 93.0, 148.0, 93.0, 93.0, 153.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 58.0, 67.0, 57.0, 57.0, 75.0, 55.0, 54.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 81.0, 86.0, 81.0, 81.0, 90.0, 82.0, 81.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 130.0, 127.0, 135.0, 136.0, 130.0, 128.0, 161.0, 138.0], "value": 134.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 163.0, 169.0, 172.0, 165.0, 165.0, 165.0, 168.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 70.0, 66.0, 67.0, 68.0, 67.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1554.1, "alertThreshold": 2.0}]} 05:28:01 INFO - Return code: 0 05:28:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:01 ERROR - # TBPL SUCCESS # 05:28:01 INFO - Running post-action listener: _resource_record_post_action 05:28:01 INFO - Running post-run listener: _resource_record_post_run 05:28:02 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 404779008; Read time: 0; Write time: 286960 05:28:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113840128; Read time: 0; Write time: 74392 05:28:02 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 290938880; Read time: 0; Write time: 212568 05:28:02 INFO - Running post-run listener: _upload_blobber_files 05:28:02 INFO - Blob upload gear active. 05:28:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:02 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 05:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:28:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:04 INFO - (blobuploader) - INFO - Done attempting. 05:28:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:04 INFO - (blobuploader) - INFO - Done attempting. 05:28:04 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:04 INFO - Return code: 0 05:28:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/253e32ea3c4687659c0a3021fc497c2b42512f2b59feed833b0d631747630c9563b16b6151956b6fc21ac32c7b03b87c22141905e41173a012d79bb0e1d4af63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b11b2f325ba23a1bfd8834419982e5d3ea4303825c3e7c871db0feb4f8cbd552dbce3a18fffdf9c69987bcd67a02fac79c58cf1f4322572038d2eee93a23bd"} 05:28:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:04 INFO - Contents: 05:28:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/253e32ea3c4687659c0a3021fc497c2b42512f2b59feed833b0d631747630c9563b16b6151956b6fc21ac32c7b03b87c22141905e41173a012d79bb0e1d4af63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b11b2f325ba23a1bfd8834419982e5d3ea4303825c3e7c871db0feb4f8cbd552dbce3a18fffdf9c69987bcd67a02fac79c58cf1f4322572038d2eee93a23bd"} 05:28:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:04 INFO - Copying logs to upload dir... 05:28:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.981454 ========= master_lag: 252.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 47 secs) (at 2016-04-15 05:32:17.134501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-15 05:32:17.138462) ========= 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=d2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/253e32ea3c4687659c0a3021fc497c2b42512f2b59feed833b0d631747630c9563b16b6151956b6fc21ac32c7b03b87c22141905e41173a012d79bb0e1d4af63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b11b2f325ba23a1bfd8834419982e5d3ea4303825c3e7c871db0feb4f8cbd552dbce3a18fffdf9c69987bcd67a02fac79c58cf1f4322572038d2eee93a23bd"} build_url:https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/FD2RuupkRk6tlqbPpVT0eQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/253e32ea3c4687659c0a3021fc497c2b42512f2b59feed833b0d631747630c9563b16b6151956b6fc21ac32c7b03b87c22141905e41173a012d79bb0e1d4af63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48b11b2f325ba23a1bfd8834419982e5d3ea4303825c3e7c871db0feb4f8cbd552dbce3a18fffdf9c69987bcd67a02fac79c58cf1f4322572038d2eee93a23bd"}' ========= master_lag: 1.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-15 05:32:18.403086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:32:18.403411) ========= 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=d2a8c569965ab8367867b893000001a1-1460722047.976945-1107938937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 05:32:18.445856) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 05:32:18.446169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 05:32:18.449148) ========= ========= Total master_lag: 253.76 =========