builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1461260272.87 results: success (0) buildid: 20160421080527 builduid: 559f07941e284fa39abf5f607ddd0126 revision: 4ac3b4265ce2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:52.867358) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:52.867839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:52.868233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:52.881992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:52.882317) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 10:37:52-- 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% 46.8M=0s 2016-04-21 10:37:52 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121046 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.015827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.016155) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019378 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.067701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.068331) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4ac3b4265ce2 --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 4ac3b4265ce2 --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=5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 10:37:53,105 Setting DEBUG logging. 2016-04-21 10:37:53,106 attempt 1/10 2016-04-21 10:37:53,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4ac3b4265ce2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 10:37:53,360 unpacking tar archive at: fx-team-4ac3b4265ce2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.630978) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.631314) ========= script_repo_revision: 4ac3b4265ce2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.631715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.631996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 10:37:53.641921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-21 10:37:53.642274) ========= /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=5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:37:53 INFO - MultiFileLogger online at 20160421 10:37:53 in /builds/slave/test 10:37:53 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 10:37:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:37:53 INFO - {'append_to_log': False, 10:37:53 INFO - 'base_work_dir': '/builds/slave/test', 10:37:53 INFO - 'blob_upload_branch': 'Fx-Team', 10:37:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:37:53 INFO - 'branch': 'Fx-Team', 10:37:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:37:53 INFO - 'config_files': ('talos/linux_config.py',), 10:37:53 INFO - 'default_actions': ('clobber', 10:37:53 INFO - 'read-buildbot-config', 10:37:53 INFO - 'download-and-extract', 10:37:53 INFO - 'populate-webroot', 10:37:53 INFO - 'create-virtualenv', 10:37:53 INFO - 'install', 10:37:53 INFO - 'run-tests'), 10:37:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:37:53 INFO - 'download_minidump_stackwalk': True, 10:37:53 INFO - 'download_symbols': 'ondemand', 10:37:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:37:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:37:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:37:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:37:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:37:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:37:53 INFO - 'installer_path': 'installer.exe', 10:37:53 INFO - 'log_level': 'info', 10:37:53 INFO - 'log_name': 'talos', 10:37:53 INFO - 'log_to_console': True, 10:37:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:37:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:37:53 INFO - 'opt_config_files': (), 10:37:53 INFO - 'pip_index': False, 10:37:53 INFO - 'sps_profile': False, 10:37:53 INFO - 'sps_profile_interval': 0, 10:37:53 INFO - 'suite': 'dromaeojs', 10:37:53 INFO - 'system_bits': '32', 10:37:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:37:53 INFO - 'title': 'talos-linux64-ix-039', 10:37:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:37:53 INFO - 'use_talos_json': True, 10:37:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:37:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:37:53 INFO - 'work_dir': 'build'} 10:37:53 INFO - ##### 10:37:53 INFO - ##### Running clobber step. 10:37:53 INFO - ##### 10:37:53 INFO - Running pre-action listener: _resource_record_pre_action 10:37:53 INFO - Running main action method: clobber 10:37:53 INFO - rmtree: /builds/slave/test/build 10:37:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:37:54 INFO - Running post-action listener: _resource_record_post_action 10:37:54 INFO - ##### 10:37:54 INFO - ##### Running read-buildbot-config step. 10:37:54 INFO - ##### 10:37:54 INFO - Running pre-action listener: _resource_record_pre_action 10:37:54 INFO - Running main action method: read_buildbot_config 10:37:54 INFO - Using buildbot properties: 10:37:54 INFO - { 10:37:54 INFO - "project": "", 10:37:54 INFO - "product": "firefox", 10:37:54 INFO - "script_repo_revision": "production", 10:37:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:37:54 INFO - "repository": "", 10:37:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:37:54 INFO - "buildid": "20160421080527", 10:37:54 INFO - "pgo_build": "True", 10:37:54 INFO - "basedir": "/builds/slave/test", 10:37:54 INFO - "buildnumber": 592, 10:37:54 INFO - "slavename": "talos-linux64-ix-039", 10:37:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:37:54 INFO - "platform": "ubuntu64_hw", 10:37:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:37:54 INFO - "branch": "fx-team", 10:37:54 INFO - "repo_path": "integration/fx-team", 10:37:54 INFO - "revision": "4ac3b4265ce2", 10:37:54 INFO - "stage_platform": "linux64-pgo", 10:37:54 INFO - "builduid": "559f07941e284fa39abf5f607ddd0126", 10:37:54 INFO - "slavebuilddir": "test" 10:37:54 INFO - } 10:37:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:37:54 INFO - Running post-action listener: _resource_record_post_action 10:37:54 INFO - ##### 10:37:54 INFO - ##### Running download-and-extract step. 10:37:54 INFO - ##### 10:37:54 INFO - Running pre-action listener: _resource_record_pre_action 10:37:54 INFO - Running main action method: download_and_extract 10:37:54 INFO - mkdir: /builds/slave/test/build/tests 10:37: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')]} 10:37:54 INFO - https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:37:54 INFO - Downloaded 1361 bytes. 10:37:54 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:37:54 INFO - Using the following test package requirements: 10:37:54 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:37:54 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:37:54 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:37:54 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'jsshell-linux-x86_64.zip'], 10:37:54 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:37:54 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:37:54 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:37:54 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:37:54 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:37:54 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:54 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:37:54 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:37: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')]} 10:37:54 INFO - https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:37:56 INFO - Downloaded 23848049 bytes. 10:37:56 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'] 10:37:56 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 10:37:58 INFO - Return code: 0 10:37:58 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 10:37: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')]} 10:37:58 INFO - https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:37:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:37:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:37:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:37:59 INFO - Downloaded 23848049 bytes. 10:37:59 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'] 10:37:59 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 10:38:00 INFO - Return code: 0 10:38:00 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')]} 10:38:00 INFO - https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:38:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:38:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:38:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:38:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:38:01 INFO - Downloaded 10845952 bytes. 10:38:01 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'] 10:38:01 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 10:38:02 INFO - Return code: 0 10:38:02 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')]} 10:38:02 INFO - https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:38:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:38:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:38:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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 10:38:03 INFO - Downloaded 58331693 bytes. 10:38:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:38:03 INFO - mkdir: /builds/slave/test/properties 10:38:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:38:03 INFO - Writing to file /builds/slave/test/properties/build_url 10:38:03 INFO - Contents: 10:38:03 INFO - build_url:https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:38:04 INFO - Running post-action listener: _resource_record_post_action 10:38:04 INFO - Running post-action listener: set_extra_try_arguments 10:38:04 INFO - ##### 10:38:04 INFO - ##### Running populate-webroot step. 10:38:04 INFO - ##### 10:38:04 INFO - Running pre-action listener: _resource_record_pre_action 10:38:04 INFO - Running main action method: populate_webroot 10:38:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:38:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:38:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:38:04 INFO - '--tppagecycles', 10:38:04 INFO - '7'], 10:38:04 INFO - 'tests': ['tsvgm']}}, 10:38:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:38:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:38:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:38:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:38:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['damp', 'tps']}, 10:38:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'tests': ['damp', 'tps']}, 10:38:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['dromaeo_dom']}, 10:38:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:38:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['a11yr', 10:38:04 INFO - 'ts_paint', 10:38:04 INFO - 'tpaint', 10:38:04 INFO - 'sessionrestore', 10:38:04 INFO - 'sessionrestore_no_auto_restore', 10:38:04 INFO - 'tabpaint']}, 10:38:04 INFO - 'other-e10s': {'tests': ['a11yr', 10:38:04 INFO - 'ts_paint', 10:38:04 INFO - 'tpaint', 10:38:04 INFO - 'sessionrestore', 10:38:04 INFO - 'sessionrestore_no_auto_restore', 10:38:04 INFO - 'tabpaint']}, 10:38:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:38:04 INFO - 'ts_paint', 10:38:04 INFO - 'tpaint', 10:38:04 INFO - 'sessionrestore', 10:38:04 INFO - 'sessionrestore_no_auto_restore', 10:38:04 INFO - 'tabpaint']}, 10:38:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:38:04 INFO - 'ts_paint', 10:38:04 INFO - 'tpaint', 10:38:04 INFO - 'sessionrestore', 10:38:04 INFO - 'sessionrestore_no_auto_restore', 10:38:04 INFO - 'tabpaint']}, 10:38:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['a11yr', 10:38:04 INFO - 'ts_paint', 10:38:04 INFO - 'tpaint', 10:38:04 INFO - 'sessionrestore', 10:38:04 INFO - 'sessionrestore_no_auto_restore', 10:38:04 INFO - 'tabpaint']}, 10:38:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['a11yr', 10:38:04 INFO - 'ts_paint', 10:38:04 INFO - 'tpaint', 10:38:04 INFO - 'sessionrestore', 10:38:04 INFO - 'sessionrestore_no_auto_restore', 10:38:04 INFO - 'tabpaint']}, 10:38:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['tsvgx', 10:38:04 INFO - 'tsvgr_opacity', 10:38:04 INFO - 'tart', 10:38:04 INFO - 'tscrollx', 10:38:04 INFO - 'cart']}, 10:38:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:38:04 INFO - 'tsvgr_opacity', 10:38:04 INFO - 'tart', 10:38:04 INFO - 'tscrollx', 10:38:04 INFO - 'cart']}, 10:38:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'talos_options': ['--disable-e10s'], 10:38:04 INFO - 'tests': ['tp5o']}, 10:38:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'tests': ['tp5o']}, 10:38:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'talos_options': ['--disable-e10s', 10:38:04 INFO - '--xperf_path', 10:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:04 INFO - 'tests': ['tp5n']}, 10:38:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:04 INFO - 'talos_options': ['--xperf_path', 10:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:04 INFO - 'tests': ['tp5n']}}, 10:38:04 INFO - 'talos.zip': {'path': '', 10:38:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:38:04 INFO - Running post-action listener: _resource_record_post_action 10:38:04 INFO - ##### 10:38:04 INFO - ##### Running create-virtualenv step. 10:38:04 INFO - ##### 10:38:04 INFO - Running pre-action listener: _resource_record_pre_action 10:38:04 INFO - Running main action method: create_virtualenv 10:38:04 INFO - Creating virtualenv /builds/slave/test/build/venv 10:38:04 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 10:38:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:38:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:38:04 INFO - Using real prefix '/usr' 10:38:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:38:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:38:06 INFO - Installing pip.................done. 10:38:06 INFO - Return code: 0 10:38:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:38:06 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')]} 10:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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')]} 10:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:06 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 10:38:06 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 10:38:06 INFO - Using env: {'DISPLAY': ':0', 10:38:06 INFO - 'HOME': '/home/cltbld', 10:38:06 INFO - 'LANG': 'en_US.UTF-8', 10:38:06 INFO - 'LANGUAGE': 'en_US:en', 10:38:06 INFO - 'LOGNAME': 'cltbld', 10:38:06 INFO - 'MAIL': '/var/mail/cltbld', 10:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:06 INFO - 'MOZ_NO_REMOTE': '1', 10:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:06 INFO - 'NO_EM_RESTART': '1', 10:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:06 INFO - 'PWD': '/builds/slave/test', 10:38:06 INFO - 'SHELL': '/bin/bash', 10:38:06 INFO - 'SHLVL': '1', 10:38:06 INFO - 'TERM': 'linux', 10:38:06 INFO - 'TMOUT': '86400', 10:38:06 INFO - 'USER': 'cltbld', 10:38:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:06 INFO - '_': '/tools/buildbot/bin/python'} 10:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:06 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 10:38:06 INFO - Cleaning up... 10:38:06 INFO - Return code: 0 10:38:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:38:06 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')]} 10:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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')]} 10:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:06 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 10:38:06 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 10:38:06 INFO - Using env: {'DISPLAY': ':0', 10:38:06 INFO - 'HOME': '/home/cltbld', 10:38:06 INFO - 'LANG': 'en_US.UTF-8', 10:38:06 INFO - 'LANGUAGE': 'en_US:en', 10:38:06 INFO - 'LOGNAME': 'cltbld', 10:38:06 INFO - 'MAIL': '/var/mail/cltbld', 10:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:06 INFO - 'MOZ_NO_REMOTE': '1', 10:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:06 INFO - 'NO_EM_RESTART': '1', 10:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:06 INFO - 'PWD': '/builds/slave/test', 10:38:06 INFO - 'SHELL': '/bin/bash', 10:38:06 INFO - 'SHLVL': '1', 10:38:06 INFO - 'TERM': 'linux', 10:38:06 INFO - 'TMOUT': '86400', 10:38:06 INFO - 'USER': 'cltbld', 10:38:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:06 INFO - '_': '/tools/buildbot/bin/python'} 10:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:07 INFO - Downloading/unpacking psutil>=0.7.1 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:38:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:09 INFO - Installing collected packages: psutil 10:38:09 INFO - Running setup.py install for psutil 10:38:09 INFO - building 'psutil._psutil_linux' extension 10:38:09 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 10:38:09 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 10:38:09 INFO - building 'psutil._psutil_posix' extension 10:38:09 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 10:38:09 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 10:38:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:09 INFO - Successfully installed psutil 10:38:09 INFO - Cleaning up... 10:38:09 INFO - Return code: 0 10:38:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:38:09 INFO - Using env: {'DISPLAY': ':0', 10:38:09 INFO - 'HOME': '/home/cltbld', 10:38:09 INFO - 'LANG': 'en_US.UTF-8', 10:38:09 INFO - 'LANGUAGE': 'en_US:en', 10:38:09 INFO - 'LOGNAME': 'cltbld', 10:38:09 INFO - 'MAIL': '/var/mail/cltbld', 10:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:09 INFO - 'MOZ_NO_REMOTE': '1', 10:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:09 INFO - 'NO_EM_RESTART': '1', 10:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:09 INFO - 'PWD': '/builds/slave/test', 10:38:09 INFO - 'SHELL': '/bin/bash', 10:38:09 INFO - 'SHLVL': '1', 10:38:09 INFO - 'TERM': 'linux', 10:38:09 INFO - 'TMOUT': '86400', 10:38:09 INFO - 'USER': 'cltbld', 10:38:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:09 INFO - '_': '/tools/buildbot/bin/python'} 10:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:38:11 INFO - Installing collected packages: mozsystemmonitor 10:38:11 INFO - Running setup.py install for mozsystemmonitor 10:38:11 INFO - Successfully installed mozsystemmonitor 10:38:11 INFO - Cleaning up... 10:38:11 INFO - Return code: 0 10:38:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:38:11 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')]} 10:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:11 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')]} 10:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:11 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:11 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 10:38:11 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 10:38:11 INFO - Using env: {'DISPLAY': ':0', 10:38:11 INFO - 'HOME': '/home/cltbld', 10:38:11 INFO - 'LANG': 'en_US.UTF-8', 10:38:11 INFO - 'LANGUAGE': 'en_US:en', 10:38:11 INFO - 'LOGNAME': 'cltbld', 10:38:11 INFO - 'MAIL': '/var/mail/cltbld', 10:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:11 INFO - 'MOZ_NO_REMOTE': '1', 10:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:11 INFO - 'NO_EM_RESTART': '1', 10:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:11 INFO - 'PWD': '/builds/slave/test', 10:38:11 INFO - 'SHELL': '/bin/bash', 10:38:11 INFO - 'SHLVL': '1', 10:38:11 INFO - 'TERM': 'linux', 10:38:11 INFO - 'TMOUT': '86400', 10:38:11 INFO - 'USER': 'cltbld', 10:38:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:11 INFO - '_': '/tools/buildbot/bin/python'} 10:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:38:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:38:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:14 INFO - Downloading docopt-0.6.1.tar.gz 10:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:38:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:38:14 INFO - Running setup.py install for blobuploader 10:38:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:38:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:38:15 INFO - Running setup.py install for requests 10:38:15 INFO - Running setup.py install for docopt 10:38:15 INFO - Successfully installed blobuploader requests docopt 10:38:15 INFO - Cleaning up... 10:38:15 INFO - Return code: 0 10:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:15 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')]} 10:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:15 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')]} 10:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:15 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:15 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 10:38:15 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 10:38:15 INFO - Using env: {'DISPLAY': ':0', 10:38:15 INFO - 'HOME': '/home/cltbld', 10:38:15 INFO - 'LANG': 'en_US.UTF-8', 10:38:15 INFO - 'LANGUAGE': 'en_US:en', 10:38:15 INFO - 'LOGNAME': 'cltbld', 10:38:15 INFO - 'MAIL': '/var/mail/cltbld', 10:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:15 INFO - 'MOZ_NO_REMOTE': '1', 10:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:15 INFO - 'NO_EM_RESTART': '1', 10:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:15 INFO - 'PWD': '/builds/slave/test', 10:38:15 INFO - 'SHELL': '/bin/bash', 10:38:15 INFO - 'SHLVL': '1', 10:38:15 INFO - 'TERM': 'linux', 10:38:15 INFO - 'TMOUT': '86400', 10:38:15 INFO - 'USER': 'cltbld', 10:38:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:15 INFO - '_': '/tools/buildbot/bin/python'} 10:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:15 INFO - Running setup.py (path:/tmp/pip-GD1Hlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:15 INFO - Running setup.py (path:/tmp/pip-26N3U7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:15 INFO - Running setup.py (path:/tmp/pip-mDL0De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:15 INFO - Running setup.py (path:/tmp/pip-xWj6Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:16 INFO - Running setup.py (path:/tmp/pip-7sRD7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:16 INFO - Running setup.py (path:/tmp/pip-2UoSfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:16 INFO - Running setup.py (path:/tmp/pip-gcydzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:16 INFO - Running setup.py (path:/tmp/pip-BVl4ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:16 INFO - Running setup.py (path:/tmp/pip-n6DCZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:16 INFO - Running setup.py (path:/tmp/pip-N4oBE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:16 INFO - Running setup.py (path:/tmp/pip-6SUKIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:16 INFO - Running setup.py (path:/tmp/pip-mjXLJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:16 INFO - Running setup.py (path:/tmp/pip-ImkM3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:16 INFO - Running setup.py (path:/tmp/pip-W2YooI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:16 INFO - Running setup.py (path:/tmp/pip-4rWWMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:16 INFO - Running setup.py (path:/tmp/pip-xRToey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:16 INFO - Running setup.py (path:/tmp/pip-CVhpSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:38:16 INFO - Running setup.py install for manifestparser 10:38:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Running setup.py install for mozcrash 10:38:17 INFO - Running setup.py install for mozdebug 10:38:17 INFO - Running setup.py install for mozdevice 10:38:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Running setup.py install for mozfile 10:38:17 INFO - Running setup.py install for mozhttpd 10:38:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Running setup.py install for mozinfo 10:38:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Running setup.py install for mozInstall 10:38:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Running setup.py install for mozleak 10:38:17 INFO - Running setup.py install for mozlog 10:38:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:38:17 INFO - Running setup.py install for moznetwork 10:38:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:38:18 INFO - Running setup.py install for mozprocess 10:38:18 INFO - Running setup.py install for mozprofile 10:38:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:38:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:38:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:38:18 INFO - Running setup.py install for mozrunner 10:38:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:38:18 INFO - Running setup.py install for mozscreenshot 10:38:18 INFO - Running setup.py install for moztest 10:38:18 INFO - Running setup.py install for mozversion 10:38:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:38:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:38:18 INFO - Cleaning up... 10:38:18 INFO - Return code: 0 10:38:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:18 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')]} 10:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:18 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')]} 10:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:18 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:18 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 10:38:18 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 10:38:18 INFO - Using env: {'DISPLAY': ':0', 10:38:18 INFO - 'HOME': '/home/cltbld', 10:38:18 INFO - 'LANG': 'en_US.UTF-8', 10:38:18 INFO - 'LANGUAGE': 'en_US:en', 10:38:18 INFO - 'LOGNAME': 'cltbld', 10:38:18 INFO - 'MAIL': '/var/mail/cltbld', 10:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:18 INFO - 'MOZ_NO_REMOTE': '1', 10:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:18 INFO - 'NO_EM_RESTART': '1', 10:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:18 INFO - 'PWD': '/builds/slave/test', 10:38:18 INFO - 'SHELL': '/bin/bash', 10:38:18 INFO - 'SHLVL': '1', 10:38:18 INFO - 'TERM': 'linux', 10:38:18 INFO - 'TMOUT': '86400', 10:38:18 INFO - 'USER': 'cltbld', 10:38:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:18 INFO - '_': '/tools/buildbot/bin/python'} 10:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:18 INFO - Running setup.py (path:/tmp/pip-aoajVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:19 INFO - Running setup.py (path:/tmp/pip-FEr2YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:19 INFO - Running setup.py (path:/tmp/pip-2upKsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:19 INFO - Running setup.py (path:/tmp/pip-mIO7R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:19 INFO - Running setup.py (path:/tmp/pip-YGtzwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:19 INFO - Running setup.py (path:/tmp/pip-IiQiS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 INFO - Running setup.py (path:/tmp/pip-vzFSCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 INFO - Running setup.py (path:/tmp/pip-QvEp2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:19 INFO - Running setup.py (path:/tmp/pip-vsRG_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:19 INFO - Running setup.py (path:/tmp/pip-HSKOA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 INFO - Running setup.py (path:/tmp/pip-ofPCk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 INFO - Running setup.py (path:/tmp/pip-_5Xkky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:19 INFO - Running setup.py (path:/tmp/pip-e2H3yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:19 INFO - Running setup.py (path:/tmp/pip-goXty1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:19 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)) 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:19 INFO - Running setup.py (path:/tmp/pip-nH7jdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:20 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)) 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:20 INFO - Running setup.py (path:/tmp/pip-NN8ukA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:20 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)) 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:20 INFO - Running setup.py (path:/tmp/pip-u39yqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:20 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)) 10:38:20 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)) 10:38:20 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)) 10:38:20 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)) 10:38:20 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)) 10:38:20 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)) 10:38:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38:20 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 10:38:20 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 10:38:20 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 10:38:20 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 10:38:20 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 10:38:20 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 10:38:22 INFO - Downloading blessings-1.6.tar.gz 10:38:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:38:22 INFO - Installing collected packages: blessings 10:38:22 INFO - Running setup.py install for blessings 10:38:22 INFO - Successfully installed blessings 10:38:22 INFO - Cleaning up... 10:38:22 INFO - Return code: 0 10:38:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:22 INFO - Reading from file tmpfile_stdout 10:38:22 INFO - Current package versions: 10:38:22 INFO - argparse == 1.2.1 10:38:22 INFO - blessings == 1.6 10:38:22 INFO - blobuploader == 1.2.4 10:38:22 INFO - docopt == 0.6.1 10:38:22 INFO - manifestparser == 1.1 10:38:22 INFO - mozInstall == 1.12 10:38:22 INFO - mozcrash == 0.17 10:38:22 INFO - mozdebug == 0.1 10:38:22 INFO - mozdevice == 0.48 10:38:22 INFO - mozfile == 1.2 10:38:22 INFO - mozhttpd == 0.7 10:38:22 INFO - mozinfo == 0.9 10:38:22 INFO - mozleak == 0.1 10:38:22 INFO - mozlog == 3.1 10:38:22 INFO - moznetwork == 0.27 10:38:22 INFO - mozprocess == 0.22 10:38:22 INFO - mozprofile == 0.28 10:38:22 INFO - mozrunner == 6.11 10:38:22 INFO - mozscreenshot == 0.1 10:38:22 INFO - mozsystemmonitor == 0.0 10:38:22 INFO - moztest == 0.7 10:38:22 INFO - mozversion == 1.4 10:38:22 INFO - psutil == 3.1.1 10:38:22 INFO - requests == 1.2.3 10:38:22 INFO - wsgiref == 0.1.2 10:38:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:22 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')]} 10:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:22 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')]} 10:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:22 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:22 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 10:38:22 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 10:38:22 INFO - Using env: {'DISPLAY': ':0', 10:38:22 INFO - 'HOME': '/home/cltbld', 10:38:22 INFO - 'LANG': 'en_US.UTF-8', 10:38:22 INFO - 'LANGUAGE': 'en_US:en', 10:38:22 INFO - 'LOGNAME': 'cltbld', 10:38:22 INFO - 'MAIL': '/var/mail/cltbld', 10:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:22 INFO - 'MOZ_NO_REMOTE': '1', 10:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:22 INFO - 'NO_EM_RESTART': '1', 10:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:22 INFO - 'PWD': '/builds/slave/test', 10:38:22 INFO - 'SHELL': '/bin/bash', 10:38:22 INFO - 'SHLVL': '1', 10:38:22 INFO - 'TERM': 'linux', 10:38:22 INFO - 'TMOUT': '86400', 10:38:22 INFO - 'USER': 'cltbld', 10:38:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:22 INFO - '_': '/tools/buildbot/bin/python'} 10:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 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)) 10:38:22 INFO - Cleaning up... 10:38:22 INFO - Return code: 0 10:38:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:38:22 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')]} 10:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:22 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')]} 10:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:22 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:22 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 10:38:22 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 10:38:22 INFO - Using env: {'DISPLAY': ':0', 10:38:22 INFO - 'HOME': '/home/cltbld', 10:38:22 INFO - 'LANG': 'en_US.UTF-8', 10:38:22 INFO - 'LANGUAGE': 'en_US:en', 10:38:22 INFO - 'LOGNAME': 'cltbld', 10:38:22 INFO - 'MAIL': '/var/mail/cltbld', 10:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:22 INFO - 'MOZ_NO_REMOTE': '1', 10:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:22 INFO - 'NO_EM_RESTART': '1', 10:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:22 INFO - 'PWD': '/builds/slave/test', 10:38:22 INFO - 'SHELL': '/bin/bash', 10:38:22 INFO - 'SHLVL': '1', 10:38:22 INFO - 'TERM': 'linux', 10:38:22 INFO - 'TMOUT': '86400', 10:38:22 INFO - 'USER': 'cltbld', 10:38:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:22 INFO - '_': '/tools/buildbot/bin/python'} 10:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:22 INFO - Downloading/unpacking jsonschema 10:38:22 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 10:38:22 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 10:38:22 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 10:38:22 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 10:38:22 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 10:38:22 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 10:38:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:38:24 INFO - Downloading/unpacking functools32 (from jsonschema) 10:38:24 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 10:38:24 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 10:38:24 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 10:38:24 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 10:38:24 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 10:38:24 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 10:38:24 INFO - Downloading functools32-3.2.3-2.tar.gz 10:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:38:25 INFO - warning: no files found matching '*.txt' 10:38:25 INFO - no previously-included directories found matching 'build' 10:38:25 INFO - no previously-included directories found matching 'dist' 10:38:25 INFO - no previously-included directories found matching '.git*' 10:38:25 INFO - Installing collected packages: jsonschema, functools32 10:38:25 INFO - Running setup.py install for functools32 10:38:25 INFO - warning: no files found matching '*.txt' 10:38:25 INFO - no previously-included directories found matching 'build' 10:38:25 INFO - no previously-included directories found matching 'dist' 10:38:25 INFO - no previously-included directories found matching '.git*' 10:38:25 INFO - Successfully installed jsonschema functools32 10:38:25 INFO - Cleaning up... 10:38:25 INFO - Return code: 0 10:38:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:38:25 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')]} 10:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:25 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')]} 10:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:25 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 0x7f593a0daf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2e9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', '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 10:38:25 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 10:38:25 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 10:38:25 INFO - Using env: {'DISPLAY': ':0', 10:38:25 INFO - 'HOME': '/home/cltbld', 10:38:25 INFO - 'LANG': 'en_US.UTF-8', 10:38:25 INFO - 'LANGUAGE': 'en_US:en', 10:38:25 INFO - 'LOGNAME': 'cltbld', 10:38:25 INFO - 'MAIL': '/var/mail/cltbld', 10:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:25 INFO - 'MOZ_NO_REMOTE': '1', 10:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:25 INFO - 'NO_EM_RESTART': '1', 10:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:25 INFO - 'PWD': '/builds/slave/test', 10:38:25 INFO - 'SHELL': '/bin/bash', 10:38:25 INFO - 'SHLVL': '1', 10:38:25 INFO - 'TERM': 'linux', 10:38:25 INFO - 'TMOUT': '86400', 10:38:25 INFO - 'USER': 'cltbld', 10:38:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:25 INFO - '_': '/tools/buildbot/bin/python'} 10:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:25 INFO - Downloading/unpacking flake8 10:38:25 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 10:38:25 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 10:38:25 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 10:38:25 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 10:38:25 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 10:38:25 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 10:38:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:38:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:38:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:27 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 10:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:38:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:38:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:38:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:38:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:38:28 INFO - no previously-included directories found matching 'docs/_build' 10:38:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:38:28 INFO - Running setup.py install for pep8 10:38:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:38:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:38:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:38:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:38:28 INFO - no previously-included directories found matching 'docs/_build' 10:38:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:38:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:38:28 INFO - Cleaning up... 10:38:28 INFO - Return code: 0 10:38:28 INFO - Running post-action listener: _resource_record_post_action 10:38:28 INFO - Running post-action listener: _start_resource_monitoring 10:38:28 INFO - Starting resource monitoring. 10:38:28 INFO - ##### 10:38:28 INFO - ##### Running install step. 10:38:28 INFO - ##### 10:38:28 INFO - Running pre-action listener: _resource_record_pre_action 10:38:28 INFO - Running main action method: install 10:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:28 INFO - Reading from file tmpfile_stdout 10:38:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:38:28 INFO - Reading from file tmpfile_stdout 10:38:28 INFO - Output received: 10:38:28 INFO - Usage: mozinstall [options] installer 10:38:28 INFO - Options: 10:38:28 INFO - -h, --help show this help message and exit 10:38:28 INFO - -d DEST, --destination=DEST 10:38:28 INFO - Directory to install application into. [default: 10:38:28 INFO - "/builds/slave/test"] 10:38:28 INFO - --app=APP Application being installed. [default: firefox] 10:38:28 INFO - mkdir: /builds/slave/test/build/application 10:38:28 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'] 10:38:28 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 10:38:45 INFO - Reading from file tmpfile_stdout 10:38:45 INFO - Output received: 10:38:45 INFO - /builds/slave/test/build/application/firefox/firefox 10:38:45 INFO - Running post-action listener: _resource_record_post_action 10:38:45 INFO - ##### 10:38:45 INFO - ##### Running run-tests step. 10:38:45 INFO - ##### 10:38:45 INFO - Running pre-action listener: _resource_record_pre_action 10:38:45 INFO - Running main action method: run_tests 10:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:38:45 INFO - Python 2.7.3 10:38:45 INFO - Return code: 0 10:38:45 INFO - grabbing minidump binary from tooltool 10:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:45 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 0x1bbd810>, '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 0x1bbe710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbeba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:38:45 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 10:38:45 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 10:38:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:38:45 INFO - Return code: 0 10:38:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:38:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:38:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:38:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:38:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:38:46 INFO - Return code: 0 10:38:46 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/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 10:38:46 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/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 10:38:46 INFO - Using env: {'DISPLAY': ':0', 10:38:46 INFO - 'HOME': '/home/cltbld', 10:38:46 INFO - 'LANG': 'en_US.UTF-8', 10:38:46 INFO - 'LANGUAGE': 'en_US:en', 10:38:46 INFO - 'LOGNAME': 'cltbld', 10:38:46 INFO - 'MAIL': '/var/mail/cltbld', 10:38:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:38:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:46 INFO - 'MOZ_NO_REMOTE': '1', 10:38:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:46 INFO - 'NO_EM_RESTART': '1', 10:38:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:46 INFO - 'PWD': '/builds/slave/test', 10:38:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:38:46 INFO - 'SHELL': '/bin/bash', 10:38:46 INFO - 'SHLVL': '1', 10:38:46 INFO - 'TERM': 'linux', 10:38:46 INFO - 'TMOUT': '86400', 10:38:46 INFO - 'USER': 'cltbld', 10:38:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760', 10:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:46 INFO - '_': '/tools/buildbot/bin/python'} 10:38:46 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/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 10:38:46 INFO - mozversion application_buildid: 20160421080527 10:38:46 INFO - mozversion application_changeset: 4ac3b4265ce2205bab28de9f09da31379e23b785 10:38:46 INFO - mozversion application_display_name: Nightly 10:38:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:38:46 INFO - mozversion application_name: Firefox 10:38:46 INFO - mozversion application_remotingname: firefox 10:38:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:38:46 INFO - mozversion application_vendor: Mozilla 10:38:46 INFO - mozversion application_version: 48.0a1 10:38:46 INFO - mozversion platform_buildid: 20160421080527 10:38:46 INFO - mozversion platform_changeset: 4ac3b4265ce2205bab28de9f09da31379e23b785 10:38:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:38:46 INFO - mozversion platform_version: 48.0a1 10:38:46 INFO - using testdate: 1461260326 10:38:46 INFO - actual date: 1461260326 10:38:46 INFO - starting webserver on 'localhost:39106' 10:38:46 INFO - SUITE-START | Running 2 tests 10:38:46 INFO - TEST-START | dromaeo_css 10:38:46 INFO - operating with platform_type : linux_ 10:38:46 INFO - Initialising browser for dromaeo_css test... 10:38:46 INFO - TEST-INFO | started process 29430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16R0mI/profile http://localhost:39106/getInfo.html) 10:38:50 INFO - PROCESS | 29430 | __metrics Screen width/height:1600/1200 10:38:50 INFO - PROCESS | 29430 | colorDepth:24 10:38:50 INFO - PROCESS | 29430 | Browser inner width/height: 1024/697 10:38:50 INFO - PROCESS | 29430 | __metrics 10:38:51 ERROR - PROCESS | 29430 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:38:52 INFO - TEST-INFO | 29430: exit 0 10:38:52 INFO - Browser initialized. 10:38:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:38:52 INFO - TEST-INFO | started process 29513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16R0mI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:04 INFO - PROCESS | 29513 | RSS: Main: 154193920 10:39:04 INFO - PROCESS | 29513 | 10:39:55 INFO - PROCESS | 29513 | 1461260395502 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] 10:42:03 INFO - PROCESS | 29513 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39106/tests/dromaeo/cssquery-ext.html) 10:42:04 INFO - PROCESS | 29513 | RSS: Main: 255832064 10:42:04 INFO - PROCESS | 29513 | 10:45:06 INFO - PROCESS | 29513 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-ext.html (next: http://localhost:39106/tests/dromaeo/cssquery-jquery.html) 10:45:06 INFO - PROCESS | 29513 | RSS: Main: 238653440 10:45:06 INFO - PROCESS | 29513 | 10:48:09 INFO - PROCESS | 29513 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39106/tests/dromaeo/cssquery-mootools.html) 10:48:09 INFO - PROCESS | 29513 | RSS: Main: 235786240 10:48:09 INFO - PROCESS | 29513 | 10:51:11 INFO - PROCESS | 29513 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39106/tests/dromaeo/cssquery-prototype.html) 10:51:12 INFO - PROCESS | 29513 | RSS: Main: 230715392 10:51:12 INFO - PROCESS | 29513 | 10:54:14 INFO - PROCESS | 29513 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39106/tests/dromaeo/cssquery-yui.html) 10:54:15 INFO - PROCESS | 29513 | RSS: Main: 220213248 10:54:15 INFO - PROCESS | 29513 | 10:57:17 INFO - PROCESS | 29513 | Cycle 1(1): loaded http://localhost:39106/tests/dromaeo/cssquery-yui.html (next: http://localhost:39106/tests/dromaeo/cssquery-dojo.html) 10:57:18 INFO - PROCESS | 29513 | RSS: Main: 267874304 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | __start_tp_report 10:57:18 INFO - PROCESS | 29513 | _x_x_mozilla_page_load 10:57:18 INFO - PROCESS | 29513 | _x_x_mozilla_page_load_details 10:57:18 INFO - PROCESS | 29513 | |i|pagename|runs| 10:57:18 INFO - PROCESS | 29513 | |0;dojo.html;3065.908022759317;3122.3755248950215;3156.40028394605;3157.8105313681167;3181.570487984123;5080.542751152396;5134.229865520174;5143.35708036495;5153.098207813627;5157.819476318325;5164.044651739431;5195.532402083812;5214.296070030545;5239.476052394759;5255.579553635709;4590.426196725392;4642.5821676049145;4761.928571071419;4803.5676789088975;4817.108834865561;4752.738599377033;4778.402699662543;4797.9760101199445;4803.159447096761;4862.149123903303;4618.122556714214;4650.697704649204;4663.603593694523;4668.6265098792355;4736.4789873114105;4587.495375508692;4594.517575654541;4600.6549508786975;4609.746463944482;4636.327732478771;4561;4575.931361029554;4580.541945805426;4590.931136032962;4622.953770462286;5108.693478391271;5165.483451654842;5202.843914682566;5206.193040078794;5236.3978142513715;5477.890442191174;5493.093639549469;5498.945010549924;5500.42245564218;5503.889922201573;5450.727463626803;5526.613137080406;5532.834014979557;5543.833684989457;5544.695041772701;5126.897462050775;5141.434442211354;5146.30524879144;5160.509751573594;5187.870303242449;5586;5587.106063029895;5588;5588.0779671354585;5648.5481161507805;5340.546053585411;5346.599005074635;5361.973190134025;5371.650842695212;5427.83716488506;5504.889902202013;5521.420250873601;5523.088690366125;5525.972370138124;5537.307836520435;5466.262054622575;5481.534069604048;5481.725913704378;5486.890262194734;5528.917066244009;5361.946380536223;5390.622656414092;5401.918971215435;5463.399026107125;5463.48096930791;4228.471441069866;4230;4233.97883010583;4239.427677263591;4273.444452221192;3802;3810.6379893910034;3815.561210460777;3822.4648549203134;3838.2707285615643;5144.948550514522;5247.344081989751;5277.709725965109;5317.813876514303;5319.46805319465;5381.48875856793;5388.326459192601;5395.595330350239;5405.486478784509;5428.104362780176;5124.871878203075;5163.044836705221;5182.404023537341;5186.481351864783;5246.842594722164;4841.636877234221;4842.782074806642;4849.660523763373;4893.681910675866;4903.803847846118;5485.369182543979;5632.183333416631;5668.433156684381;5680.346760122557;5723.542116630742;5324.733763311897;5430.83707488776;5430.968116058094;5432.239486471818;5530.668159910419;5674.233978413026;5692.31692196939;5694.088945768657;5740.799072032459;5744.597878148489;5366.919496207482;5368;5369.301990741179;5372.167314066326;5380.300560927054;5399.730013499231;5437.755301011543;5479.589030822784;5500.037493438552;5503.257060296809;5364.919526207032;5374.355077390738;5376.946230537645;5382.623216374973;5423.457654234545;5345.625806193529;5349.679019258857;5350.3312085989255;5364;5400.378956420062;5167.560757335668;5176;5270.262163297065;5272.525472707474;5289.841304760864;5416.864578385572;5436.592255580927;5441.129419292894;5445.319335083114;5452.809151679672;5347.090994531017;5347.973260133675;5356.839294821161;5359.356877174764;5397.730113494231 10:57:18 INFO - PROCESS | 29513 | |1;ext.html;605.2404232687978;625.7246811402986;635.7615894039735;654.9410553050221;657.021038652408;29976.25059373514;36922.63077369225;37806.62193378062;37871.810640946824;37933;39158.608413915856;39492.60507394932;39848.80075599625;39875;39937.201255974935;7391.778246652582;8425.494470331769;8635.568221588926;8641.52471614061;9727.464989425578;9739.464329461876;9928.702138935843;9930.05664461875;9930.851037234448;9936.652217172401;10207.285490015665;10308.48457577122;10327.27709060366;10406.531706073245;10419.218558608096;7540.396768258526;7854.8429031419055;10177.338472999232;10290.7427314317;10542.15662746986;9971.451570163637;10107.89892101077;10111.696649100466;10118.54466549007;10121.746956326151;36440.63559364399;37062.923078461616;37096.44355334672;37130.443043354375;37133.44299835504;3633.1643721943838;3774.0942173878348;4120.690948178899;4147.979260103711;4195.7063005589625;31138.377232455452;31448.842755786074;31558.526622100686;31588.684113158804;31832.363352732817;4187.937180942288;4255.63827074699;4310.4396428464415;4376.212281789277;4445.688801783876;280930;282558;283236;283494;283993;57842.7107864458;58224;58248;58272;58399;54119.72940135353;54211.72894135504;54287.18569221465;54301.72849135808;54328.45671543313;16829.747553786703;17044.914775426045;17082.658346833243;17128;17142.40001599938;13302.401391937387;13374.598762037154;13377.197368157942;13378.197308161542;13382.13016153947;15341.539753807403;16820.495385138467;16863.494095177164;16878.156092195342;16892;5171.4311425743135;6105.450509454082;6140.4473597376455;6276.529260305495;6305.8108256752375;996.3858549150278;1098.2531878322657;1102.7022703869911;1109.5007246738999;1142.994285028586;29533.704662953096;30682.53976190359;30847.537286940715;30917.38165236683;31355.84322078375;1105.1490352428584;1125.7354521687396;1132.2357408749062;1156.67613068341;1233.3031837012059;16285.185740712917;16326;16361.509154725378;16556.50330490087;16659.00045997244;401587;521608;534098;535839;537131;55452;55915.72042139763;56209.31372058845;56244;56312.43687563154;1253.692845252919;1319.7426501832242;1408.4295860176644;1422.5732280315865;1498.7676910078956;29836;31195;31825.5226171603;31896.840515797274;31978;45264.77367613141;53425;56169.43830561642;56288.15567766405;56290.718546407006;241564;243077;243445;244953;246008;24990.625140622542;27422.862885685445;27435.588466173424;27847.86076069607;27878.721212787612;41188.38217426801;42174.578254217064;42471;46706.53293467158;46807.29789053099;36782.26435471222;38882.2223555533;39251.93572351011;39349;40429.59570404376;37668.06733185676;38173.857294084584;39019.6098039016;39092.218155637296;39802.402963954984;39237.607623923395;39632.2073558533;39911.40132898067;40316.79841600773;40367.3944890821;34027.4895876567;34585.65414345825;34925.82537087298;35127.29745405129;35321.64678353183;27102;27385.726142739113;27404.862975684995;27481.587776182972;28039.43921121607 10:57:18 INFO - PROCESS | 29513 | |2;jquery.html;391.757110591433;395.3575439910145;402.09127372138977;405.9167870586529;411.13866449787685;13814.585562433143;15015.774763378531;16649.16754162293;17616.55958601034;17651.646967060668;16688.83311166888;17215.22531486083;17504.824951750477;17521.123943802824;18677.159527821248;5553.8333849984565;5666.065099258617;5699.316082070137;5721.942780572203;5726.198332233491;3974.085960229149;5658.830235092933;5708.172315014321;5886.6468011919205;6262.342454042328;6192.071189321593;6195.163652906867;6212.099245609384;6230.439260466557;6236.158118653969;5998.1602575639445;6095.3599872013465;6174.938250617503;6178.042403427476;6291.937080629181;5347.866303342447;5547.3343198816;5547.972260138674;5553.305836770403;5554.028045092133;11842.940785296018;12508.3745812709;22045.448863778533;22145.44636384087;22177.55644887093;2327.5344931013865;2415.951680966371;2439.0853429963763;2777.486897941085;2933.7799665024995;9104.31717621181;9399.812003759955;9564.18704410126;9576.377535460173;9771.364861283993;1904.438190733737;1927.267638297438;1944.8638595298335;1972.4674337928823;1986.8807871527754;51671.48328516742;53799;54079.72960135213;63022.99999999954;75908.24091759067;10134.290599657954;10418.895811041793;10656.4300959178;10988.066014388867;11006.889931100746;14960.551183464513;15078.472253471076;15111;15136.621584460256;15183.316750746242;8067.435279530494;8125.9187408126345;8224.424290299741;8251.381146413923;8307.792305192419;7685.846283074307;7693.1922148173635;8048.59757012147;8125.228103330174;8231.547264900488;4586.6789324747615;4630.768461576908;4645.790939407667;4687.81248750053;4716.127516409475;1731;1828.7714035745532;1888.6222755448964;1906.752122224102;1925.9037048147536;999.5901680311038;1024.9436281004616;1093.868735751715;1108.2766298405895;1157.479134389528;17082.829171708123;17561.648767024588;18505.629887402178;18512.611554133495;19123.139458724112;1026.645807196516;1048.2819268800895;1051.9789604207872;1057.2440704895882;1101.5043230546287;9961.153301969269;10277.229207809443;10278.201314769885;10296.639617613497;10421.53103110362;337070;337396;337742;339888;450392;85966.57016714876;91986.54006729924;92193.15613687823;92568;93182;983.7786498037884;1053.373242920461;1063.1123012284675;1107.2692023264606;1108.6275370706694;15696.686066278839;15697.529074127795;15702.21488925572;15901.60245993813;15933.68132637364;32604;32932.67067329296;34224;34525.65474345224;36252.27495450129;50028;51152.74423627858;53089;53234;53849.19226211531;7620.428467864822;7927.165442326827;8066.354691624539;8070.314023308085;8258.091609923023;12334.691632709255;12362.938185309016;12485.375731213222;12736.490540378281;12774.552890648783;11155.665330040112;11426.314421134759;11600.825987610362;11664.241824281735;11923.582674606347;10982.165586020014;11064.446777661246;11192.552297908318;11424.371659558805;11882.10884183707;11294.265872718248;11515.25150865191;11603.883961160618;11785.057195424517;11873.881261187624;8056.798580035312;8146.83706325882;8358.791030224049;8434.662613495391;8502.319814414956;9722.80554388894;11238.15713821483;11259.49332280033;11331.546738130382;11382.54469821198 10:57:18 INFO - PROCESS | 29513 | |3;mootools.html;1205.0359712230213;1527.8319384867666;1557.4626753769946;1721.1824383417877;1817.4002579148873;7573.166951635316;7865.724699635514;7885.921140788598;7906.92093079069;7918;7702.576358300291;7839.764807055783;7862.606869656509;7863.331616812564;7870.055593328794;1932.7680678318552;1990.5222746540799;2139.2619546256515;2164.7835216478306;2189.025883481851;2253.695751073609;2272.0457407888644;2274.5109801392696;2275.488015196576;2278.624027035537;2191.9780802191935;2203.8126759225484;2228.2869481765842;2230.185982116524;2232.866028038323;1854.8516118710538;1924.490010147312;2095.4656562576447;2169.229923377194;2173.6956826044366;2229.0637932068407;2243.6298010828195;2246.427161073932;2247.314569056437;2249.7975182233677;7896.921030789734;7936.047674279123;7941.126476087626;7955.204479551999;7957.124716281204;4535.138323718483;4664.160451118797;4667.603253723438;4685.929711054337;4701.294805779126;2988.6114805075417;3179.952300715491;3191.0745883693703;3197.2646291353117;3197.6162860456893;2072.336852207294;2128;2129.659254519285;2130.126648074282;2131.1475409836034;10893.455327233685;10997.560097596086;10999.175061870392;10999.505022274017;11003.33979961205;4043.2317859606583;4057.4928133983253;4082.142750022469;4092.7339722917914;4093.3041382964966;8784;8785.560721964004;8805.295576353876;8941.687040953666;8982.730518084338;4796.8081276748535;4817.662763606584;4820.493848145964;4828.493008234155;4837.4920633332995;4005.1388951375593;4314.913701725948;4421.690481666316;4429.7120687155875;4430.468343798765;3500.4749287607065;3534.681878630884;3549.378858699717;3573.2317551726505;3638.381475149178;1025.74869157057;1033.5865653738565;1034.0486752188006;1047.8323468245044;1060.8461773042866;803.9879401808978;949.6486300069018;959.4531117263093;966.0580933589835;986.146982859821;5472.2065300531995;5481.287432633732;5593.356763972114;5649.858753531113;5759.596828222068;916.1617120334952;946.0823001688351;949.5916755794937;993.4486360070231;1018.4398580780542;3741.8877433677035;3753.4557489163917;3827.349350610403;3832.6358995895343;3861.1119442528375;9367.531623418801;9455.243580513543;9714.319997600242;9816;9843.261755368376;9598.472084035446;9647.71056868295;9742.853857192147;9754.317197796228;9772.951135244279;7397;7443.069616297963;7483.13943896448;7640.388768898586;7671.194524574951;5744.454276843693;5770.942290577041;5828.76684932598;5854.94145058561;5862.853428664147;9154.084591540792;9319.207867331354;9385.718428447157;9401.670941517013;9464.290178236522;9062.637494500146;9437.764055898657;9474.810503790024;9530.904690953279;9672.129508344282;6542.640154791342;6987.301269872972;7037.472189585699;7148;7175.748848790267;7865.252800983897;7903.525788452711;7957.602119893866;7965.681372745025;7969.242921922408;6834.794956151323;7120.216776154515;7137.179224389261;7226.963865180641;7275.163356214103;6965.79102626922;7135.143782746104;7156.177039640508;7244.166920803964;7296.379807716404;6230.314665386894;6339.1125242467015;6343.746250149942;6344.841378965562;6353.301136875032;4738.573528382462;4768.856934291976;4809.2064809306075;4879.926801097916;4917.360743103373;4740.976295118502;4795.520447955177;4842.757862106951;4934.481879402611;4943.456219815889 10:57:18 INFO - PROCESS | 29513 | |4;prototype.html;299.6538997457937;312.63421796498096;314.61412478034254;324.7272291275329;326.83821508353367;5395.7032363220005;5536.169574563817;5536.4186760390185;5621.4940655341015;5652.180433837097;5507.862303442406;5512.448755124496;5531.834044978647;5555.2778138841995;5602.355729091156;4332.111917057004;4332.978335108336;4333.706383148814;4345.065810850667;4346.022974262624;4035.354343305072;4165.937510937339;4304.203722311367;4330.631896288819;4345.804438800262;4251.107267473834;4281.529031806499;4299.828586563796;4304.31131019037;4314.784260786963;4246.341817018367;4248.171606536726;4275.572442755731;4275.743455392686;4290.892727681801;3646.32542979547;3771.811409429545;3774.037620406806;3782.451544526028;3784.4701741756176;5284.762185701653;5340.519353258225;5351;5356.303680521546;5370.194470829368;4884.5848102911295;4888.511148885119;4891.75541222941;4895.804167833318;4896.706197628154;5665.49010589049;5730.02038939749;5788.176724331822;5800.389824578914;5825.563082768809;4101.97949010256;4129.318662420697;4130.277201489727;4132.752034877887;4136.669066474675;6099.207103076572;6115.388461153849;6115.737177244404;6137.6624285664275;6138.8772224555705;4137.565555616678;4223.767692776865;4234.237837189274;4234.851780187679;4244.0663054128045;4239.533651298355;4244.3209086546;4251.383549385322;4255.340422234559;4279.101388708406;4863.416390033219;4884.462709101996;4886.120498310267;4886.267059941038;4886.755662216875;5622.762992141722;5796.449337312949;5801.622894511843;5861.6189947653265;5869.090291004901;1350.9662258443618;1396.4484028808563;1441.5891470930735;1442.4662874736205;1447.6959838433836;944.419182202954;949.928755343352;952.5761036338902;966.8453047512364;969.0793745941384;5632.887342253214;5641.605087643908;5643.830685079454;5646.20953066571;5653.802116925888;5888.764449422061;5889.882202355929;5911.852203694856;5915.077599780003;5944.316403613553;5485.369182543979;5667.348254950651;5674.432556744293;5784.971075144597;5837.9124313135335;3243.1729908873085;3264.922575550063;3270.1824543864036;3271.7219036382176;3274.672532746754;6222.937770622327;6344.809655710336;6392.648404337713;6396.744130234739;6421.967890160519;6204.565680402328;6224.470919971763;6225.782097626561;6237.313895471494;6246.501958903029;6317.3366796486625;6317.905231421624;6318.6524741138755;6329.398707122816;6356.555041147168;5886.646801191942;6085.57400981927;6087.908681369871;6089.177960975212;6113.29697084841;5908.763649453974;5909.261342332208;5913.231279933581;5934.406559344031;5971.4327138921735;6158.969205153946;6350.396712312323;6352.491800656029;6356.396142366468;6376.234851817811;4034.314166591628;4037.2329257440992;4039.4546736191414;4061.329880569791;4068.14568940514;5770.336411312753;6051.273847138372;6080.300765412034;6088.786892458743;6112.694365281807;5608.040897326179;5760.107183386582;5760.6255593386295;5779.450952159538;5819.738111785065;5886.646801191942;5898.174255604305;5902.52094120479;5929.644221346733;5943.375945525658;5674.0565307111165;5725;5770.172615418331;5781.739821708117;5827.125931110198;5928.584999050025;5934.495567876779;5942.732577033958;5949.791757288474;5964.451151564812;5799.884002320015;5827.475527202572;5831.650100993784;5832.212651292191;5842.591018628656 10:57:18 INFO - PROCESS | 29513 | |5;yui.html;694.458322508443;836.7531578184436;843.5444859775721;860.0539406652679;863.2230992107103;13037.869621303784;13187.604371868836;13215.471381144742;13218.867811321885;13232.73534529309;13311.134776239538;13371.732565348711;13379.59861204163;13398.866011339884;13424.261665608388;651.9054737063111;775.2634996753108;814.2305521282391;825.9008918929707;826.8759686047081;821.8602837517636;827.983440331193;828.5981299069946;828.9792755181138;829.6681327469;704.6511976571578;883.9513826739527;887.5917078144062;887.6981826179098;887.951162686052;720.895470156827;723.0600219714377;860.1957170045996;888.2849306308419;889.888763904512;622.483338828771;622.5019984012772;625.8122563231012;626.1859582542676;626.3767551286454;13167.934160329232;13170.407331670098;13186.274754888478;13188.736225275441;13255.27096009719;13786.862131378759;13839.861601383958;13963.860361396357;13989.510367137204;14080.92959535206;10498.790024199474;10533.315334503233;10550.314229575053;10594.25840191187;10651.786964260671;3889.2610404023426;3910.569837317893;3936.7637941723588;3975.662068724162;3980.5820388859333;54455.72772136154;55026;55902.16146757802;56252.71873640606;56442.71778641122;11054.668359949053;11110.111191104692;11240;11278.774424511465;11350.432478376048;20407.387778366672;20427.8978605109;20461.590768184553;20472.488187795127;20495.692564611243;7940.364770818321;7978.361731061501;7983.640736166886;8013.398995075276;8248.340132789363;4577;4611.239145541015;4696.9060618787435;4712.52874712526;4765.380500534909;3355.949660755042;3422.0418282880833;3427.8114703691535;3439.3121375724954;3445.707114895212;594.9855496378664;628.7516431009725;633.1357696744003;645.3739872323838;652.2043107408954;659;724.1816747075876;742.8959945607619;755.833716582351;773.7601343583507;8160.102388737234;8629.870551941725;8866.73399798007;8887.511186884783;8958.596863141174;713.4114355656604;719.1873183302835;719.597025665629;739.4084732214208;746.0972223609493;4252.277112890816;4322.15717935006;4436.0906014267;4495.662825288116;4541.750203738826;52023;61444;63102.68448657727;63569.04646430307;63683.681581591794;44635.77682111569;45565.77217113893;45683.5431645686;46129.308060379124;46735.29897051547;44376;45828;46322.768386158525;47363.05273894503;47607.76196119066;8719.694810681596;8810.603522841358;8838.911610884066;8982.281417486716;8988.86516702263;30338.696613033586;30936.84531577418;31168.844155779076;31399.84300078485;31666.208344791565;40816.591834082465;41053;41455.7927210362;43443.13113737644;44964;12244.265344079384;12334.198277112318;12415.75168496607;12436.19164754288;12616.053795965523;13551.390187441786;13563.525276615272;13861.37623806911;14045.157290562598;14161.787573186204;11540.192186546861;11580.710482238012;11708.941455292668;12905.225686458842;13170.934145329595;12323.75352492963;12792.61622151337;12995.935020324838;13374.06381553282;13410.39653215588;12079.39603019863;12084.939575302067;12115;12184.329861857683;12193.69515762113;10478;10706.143508519144;10780.568777248822;10797.352158870493;10852.891471085188;10742.462876855969;10874.130069594572;10952.507137178687;11082.16883733707;11145.498452569816 10:57:18 INFO - PROCESS | 29513 | __end_tp_report 10:57:18 INFO - PROCESS | 29513 | __start_cc_report 10:57:18 INFO - PROCESS | 29513 | _x_x_mozilla_cycle_collect,868 10:57:18 INFO - PROCESS | 29513 | __end_cc_report 10:57:18 INFO - PROCESS | 29513 | __startTimestamp1461261438229__endTimestamp 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | ------- Summary: start ------- 10:57:18 INFO - PROCESS | 29513 | Number of tests: 6 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | [#0] dojo.html Cycles:165 Average:5114.42 Median:5345.63 stddev:547.05 (10.2%) stddev-sans-first:524.60 10:57:18 INFO - PROCESS | 29513 | Values: 3065.9 3122.4 3156.4 3157.8 3181.6 5080.5 5134.2 5143.4 5153.1 5157.8 5164.0 5195.5 5214.3 5239.5 5255.6 4590.4 4642.6 4761.9 4803.6 4817.1 4752.7 4778.4 4798.0 4803.2 4862.1 4618.1 4650.7 4663.6 4668.6 4736.5 4587.5 4594.5 4600.7 4609.7 4636.3 4561.0 4575.9 4580.5 4590.9 4623.0 5108.7 5165.5 5202.8 5206.2 5236.4 5477.9 5493.1 5498.9 5500.4 5503.9 5450.7 5526.6 5532.8 5543.8 5544.7 5126.9 5141.4 5146.3 5160.5 5187.9 5586.0 5587.1 5588.0 5588.1 5648.5 5340.5 5346.6 5362.0 5371.7 5427.8 5504.9 5521.4 5523.1 5526.0 5537.3 5466.3 5481.5 5481.7 5486.9 5528.9 5361.9 5390.6 5401.9 5463.4 5463.5 4228.5 4230.0 4234.0 4239.4 4273.4 3802.0 3810.6 3815.6 3822.5 3838.3 5144.9 5247.3 5277.7 5317.8 5319.5 5381.5 5388.3 5395.6 5405.5 5428.1 5124.9 5163.0 5182.4 5186.5 5246.8 4841.6 4842.8 4849.7 4893.7 4903.8 5485.4 5632.2 5668.4 5680.3 5723.5 5324.7 5430.8 5431.0 5432.2 5530.7 5674.2 5692.3 5694.1 5740.8 5744.6 5366.9 5368.0 5369.3 5372.2 5380.3 5399.7 5437.8 5479.6 5500.0 5503.3 5364.9 5374.4 5376.9 5382.6 5423.5 5345.6 5349.7 5350.3 5364.0 5400.4 5167.6 5176.0 5270.3 5272.5 5289.8 5416.9 5436.6 5441.1 5445.3 5452.8 5347.1 5348.0 5356.8 5359.4 5397.7 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | [#1] ext.html Cycles:180 Average:51163.56 Median:36992.78 stddev:96644.48 (261.3%) stddev-sans-first:96841.04 10:57:18 INFO - PROCESS | 29513 | Values: 605.2 625.7 635.8 654.9 657.0 29976.3 36922.6 37806.6 37871.8 37933.0 39158.6 39492.6 39848.8 39875.0 39937.2 7391.8 8425.5 8635.6 8641.5 9727.5 9739.5 9928.7 9930.1 9930.9 9936.7 10207.3 10308.5 10327.3 10406.5 10419.2 7540.4 7854.8 10177.3 10290.7 10542.2 9971.5 10107.9 10111.7 10118.5 10121.7 36440.6 37062.9 37096.4 37130.4 37133.4 3633.2 3774.1 4120.7 4148.0 4195.7 31138.4 31448.8 31558.5 31588.7 31832.4 4187.9 4255.6 4310.4 4376.2 4445.7 280930.0 282558.0 283236.0 283494.0 283993.0 57842.7 58224.0 58248.0 58272.0 58399.0 54119.7 54211.7 54287.2 54301.7 54328.5 16829.7 17044.9 17082.7 17128.0 17142.4 13302.4 13374.6 13377.2 13378.2 13382.1 15341.5 16820.5 16863.5 16878.2 16892.0 5171.4 6105.5 6140.4 6276.5 6305.8 996.4 1098.3 1102.7 1109.5 1143.0 29533.7 30682.5 30847.5 30917.4 31355.8 1105.1 1125.7 1132.2 1156.7 1233.3 16285.2 16326.0 16361.5 16556.5 16659.0 401587.0 521608.0 534098.0 535839.0 537131.0 55452.0 55915.7 56209.3 56244.0 56312.4 1253.7 1319.7 1408.4 1422.6 1498.8 29836.0 31195.0 31825.5 31896.8 31978.0 45264.8 53425.0 56169.4 56288.2 56290.7 241564.0 243077.0 243445.0 244953.0 246008.0 24990.6 27422.9 27435.6 27847.9 27878.7 41188.4 42174.6 42471.0 46706.5 46807.3 36782.3 38882.2 39251.9 39349.0 40429.6 37668.1 38173.9 39019.6 39092.2 39802.4 39237.6 39632.2 39911.4 40316.8 40367.4 34027.5 34585.7 34925.8 35127.3 35321.6 27102.0 27385.7 27404.9 27481.6 28039.4 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | [#2] jquery.html Cycles:180 Average:23974.88 Median:17768.89 stddev:60338.42 (339.6%) stddev-sans-first:60481.70 10:57:18 INFO - PROCESS | 29513 | Values: 391.8 395.4 402.1 405.9 411.1 13814.6 15015.8 16649.2 17616.6 17651.6 16688.8 17215.2 17504.8 17521.1 18677.2 5553.8 5666.1 5699.3 5721.9 5726.2 3974.1 5658.8 5708.2 5886.6 6262.3 6192.1 6195.2 6212.1 6230.4 6236.2 5998.2 6095.4 6174.9 6178.0 6291.9 5347.9 5547.3 5548.0 5553.3 5554.0 11842.9 12508.4 22045.4 22145.4 22177.6 2327.5 2416.0 2439.1 2777.5 2933.8 9104.3 9399.8 9564.2 9576.4 9771.4 1904.4 1927.3 1944.9 1972.5 1986.9 51671.5 53799.0 54079.7 63023.0 75908.2 10134.3 10418.9 10656.4 10988.1 11006.9 14960.6 15078.5 15111.0 15136.6 15183.3 8067.4 8125.9 8224.4 8251.4 8307.8 7685.8 7693.2 8048.6 8125.2 8231.5 4586.7 4630.8 4645.8 4687.8 4716.1 1731.0 1828.8 1888.6 1906.8 1925.9 999.6 1024.9 1093.9 1108.3 1157.5 17082.8 17561.6 18505.6 18512.6 19123.1 1026.6 1048.3 1052.0 1057.2 1101.5 9961.2 10277.2 10278.2 10296.6 10421.5 337070.0 337396.0 337742.0 339888.0 450392.0 85966.6 91986.5 92193.2 92568.0 93182.0 983.8 1053.4 1063.1 1107.3 1108.6 15696.7 15697.5 15702.2 15901.6 15933.7 32604.0 32932.7 34224.0 34525.7 36252.3 50028.0 51152.7 53089.0 53234.0 53849.2 7620.4 7927.2 8066.4 8070.3 8258.1 12334.7 12362.9 12485.4 12736.5 12774.6 11155.7 11426.3 11600.8 11664.2 11923.6 10982.2 11064.4 11192.6 11424.4 11882.1 11294.3 11515.3 11603.9 11785.1 11873.9 8056.8 8146.8 8358.8 8434.7 8502.3 9722.8 11238.2 11259.5 11331.5 11382.5 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | [#3] mootools.html Cycles:180 Average:5320.33 Median:5207.83 stddev:2904.69 (55.8%) stddev-sans-first:2896.36 10:57:18 INFO - PROCESS | 29513 | Values: 1205.0 1527.8 1557.5 1721.2 1817.4 7573.2 7865.7 7885.9 7906.9 7918.0 7702.6 7839.8 7862.6 7863.3 7870.1 1932.8 1990.5 2139.3 2164.8 2189.0 2253.7 2272.0 2274.5 2275.5 2278.6 2192.0 2203.8 2228.3 2230.2 2232.9 1854.9 1924.5 2095.5 2169.2 2173.7 2229.1 2243.6 2246.4 2247.3 2249.8 7896.9 7936.0 7941.1 7955.2 7957.1 4535.1 4664.2 4667.6 4685.9 4701.3 2988.6 3180.0 3191.1 3197.3 3197.6 2072.3 2128.0 2129.7 2130.1 2131.1 10893.5 10997.6 10999.2 10999.5 11003.3 4043.2 4057.5 4082.1 4092.7 4093.3 8784.0 8785.6 8805.3 8941.7 8982.7 4796.8 4817.7 4820.5 4828.5 4837.5 4005.1 4314.9 4421.7 4429.7 4430.5 3500.5 3534.7 3549.4 3573.2 3638.4 1025.7 1033.6 1034.0 1047.8 1060.8 804.0 949.6 959.5 966.1 986.1 5472.2 5481.3 5593.4 5649.9 5759.6 916.2 946.1 949.6 993.4 1018.4 3741.9 3753.5 3827.3 3832.6 3861.1 9367.5 9455.2 9714.3 9816.0 9843.3 9598.5 9647.7 9742.9 9754.3 9773.0 7397.0 7443.1 7483.1 7640.4 7671.2 5744.5 5770.9 5828.8 5854.9 5862.9 9154.1 9319.2 9385.7 9401.7 9464.3 9062.6 9437.8 9474.8 9530.9 9672.1 6542.6 6987.3 7037.5 7148.0 7175.7 7865.3 7903.5 7957.6 7965.7 7969.2 6834.8 7120.2 7137.2 7227.0 7275.2 6965.8 7135.1 7156.2 7244.2 7296.4 6230.3 6339.1 6343.7 6344.8 6353.3 4738.6 4768.9 4809.2 4879.9 4917.4 4741.0 4795.5 4842.8 4934.5 4943.5 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | [#4] prototype.html Cycles:180 Average:4917.11 Median:5649.19 stddev:1483.39 (26.3%) stddev-sans-first:1446.49 10:57:18 INFO - PROCESS | 29513 | Values: 299.7 312.6 314.6 324.7 326.8 5395.7 5536.2 5536.4 5621.5 5652.2 5507.9 5512.4 5531.8 5555.3 5602.4 4332.1 4333.0 4333.7 4345.1 4346.0 4035.4 4165.9 4304.2 4330.6 4345.8 4251.1 4281.5 4299.8 4304.3 4314.8 4246.3 4248.2 4275.6 4275.7 4290.9 3646.3 3771.8 3774.0 3782.5 3784.5 5284.8 5340.5 5351.0 5356.3 5370.2 4884.6 4888.5 4891.8 4895.8 4896.7 5665.5 5730.0 5788.2 5800.4 5825.6 4102.0 4129.3 4130.3 4132.8 4136.7 6099.2 6115.4 6115.7 6137.7 6138.9 4137.6 4223.8 4234.2 4234.9 4244.1 4239.5 4244.3 4251.4 4255.3 4279.1 4863.4 4884.5 4886.1 4886.3 4886.8 5622.8 5796.4 5801.6 5861.6 5869.1 1351.0 1396.4 1441.6 1442.5 1447.7 944.4 949.9 952.6 966.8 969.1 5632.9 5641.6 5643.8 5646.2 5653.8 5888.8 5889.9 5911.9 5915.1 5944.3 5485.4 5667.3 5674.4 5785.0 5837.9 3243.2 3264.9 3270.2 3271.7 3274.7 6222.9 6344.8 6392.6 6396.7 6422.0 6204.6 6224.5 6225.8 6237.3 6246.5 6317.3 6317.9 6318.7 6329.4 6356.6 5886.6 6085.6 6087.9 6089.2 6113.3 5908.8 5909.3 5913.2 5934.4 5971.4 6159.0 6350.4 6352.5 6356.4 6376.2 4034.3 4037.2 4039.5 4061.3 4068.1 5770.3 6051.3 6080.3 6088.8 6112.7 5608.0 5760.1 5760.6 5779.5 5819.7 5886.6 5898.2 5902.5 5929.6 5943.4 5674.1 5725.0 5770.2 5781.7 5827.1 5928.6 5934.5 5942.7 5949.8 5964.5 5799.9 5827.5 5831.7 5832.2 5842.6 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - PROCESS | 29513 | [#5] yui.html Cycles:180 Average:14218.14 Median:23939.61 stddev:16069.38 (67.1%) stddev-sans-first:16082.37 10:57:18 INFO - PROCESS | 29513 | Values: 694.5 836.8 843.5 860.1 863.2 13037.9 13187.6 13215.5 13218.9 13232.7 13311.1 13371.7 13379.6 13398.9 13424.3 651.9 775.3 814.2 825.9 826.9 821.9 828.0 828.6 829.0 829.7 704.7 884.0 887.6 887.7 888.0 720.9 723.1 860.2 888.3 889.9 622.5 622.5 625.8 626.2 626.4 13167.9 13170.4 13186.3 13188.7 13255.3 13786.9 13839.9 13963.9 13989.5 14080.9 10498.8 10533.3 10550.3 10594.3 10651.8 3889.3 3910.6 3936.8 3975.7 3980.6 54455.7 55026.0 55902.2 56252.7 56442.7 11054.7 11110.1 11240.0 11278.8 11350.4 20407.4 20427.9 20461.6 20472.5 20495.7 7940.4 7978.4 7983.6 8013.4 8248.3 4577.0 4611.2 4696.9 4712.5 4765.4 3355.9 3422.0 3427.8 3439.3 3445.7 595.0 628.8 633.1 645.4 652.2 659.0 724.2 742.9 755.8 773.8 8160.1 8629.9 8866.7 8887.5 8958.6 713.4 719.2 719.6 739.4 746.1 4252.3 4322.2 4436.1 4495.7 4541.8 52023.0 61444.0 63102.7 63569.0 63683.7 44635.8 45565.8 45683.5 46129.3 46735.3 44376.0 45828.0 46322.8 47363.1 47607.8 8719.7 8810.6 8838.9 8982.3 8988.9 30338.7 30936.8 31168.8 31399.8 31666.2 40816.6 41053.0 41455.8 43443.1 44964.0 12244.3 12334.2 12415.8 12436.2 12616.1 13551.4 13563.5 13861.4 14045.2 14161.8 11540.2 11580.7 11708.9 12905.2 13170.9 12323.8 12792.6 12995.9 13374.1 13410.4 12079.4 12084.9 12115.0 12184.3 12193.7 10478.0 10706.1 10780.6 10797.4 10852.9 10742.5 10874.1 10952.5 11082.2 11145.5 10:57:18 INFO - PROCESS | 29513 | -------- Summary: end -------- 10:57:18 INFO - PROCESS | 29513 | 10:57:18 INFO - TEST-INFO | 29513: exit 0 10:57:18 INFO - TEST-OK | dromaeo_css | took 1112325ms 10:57:18 INFO - TEST-START | kraken 10:57:18 INFO - operating with platform_type : linux_ 10:57:19 INFO - Initialising browser for kraken test... 10:57:19 INFO - TEST-INFO | started process 29695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRWrjo/profile http://localhost:39106/getInfo.html) 10:57:22 INFO - PROCESS | 29695 | __metrics Screen width/height:1600/1200 10:57:22 INFO - PROCESS | 29695 | colorDepth:24 10:57:22 INFO - PROCESS | 29695 | Browser inner width/height: 1024/697 10:57:22 INFO - PROCESS | 29695 | __metrics 10:57:23 ERROR - PROCESS | 29695 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:57:24 INFO - TEST-INFO | 29695: exit 0 10:57:24 INFO - Browser initialized. 10:57:24 INFO - Running cycle 1/1 for kraken test... 10:57:24 INFO - TEST-INFO | started process 29776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRWrjo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:36 INFO - PROCESS | 29776 | RSS: Main: 153059328 10:57:36 INFO - PROCESS | 29776 | 10:57:38 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-beat-detection) 10:57:39 INFO - PROCESS | 29776 | RSS: Main: 208769024 10:57:39 INFO - PROCESS | 29776 | 10:57:42 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-dft) 10:57:43 INFO - PROCESS | 29776 | RSS: Main: 193552384 10:57:43 INFO - PROCESS | 29776 | 10:57:46 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-fft) 10:57:46 INFO - PROCESS | 29776 | RSS: Main: 265089024 10:57:46 INFO - PROCESS | 29776 | 10:57:48 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39106/tests/kraken/driver.html?testName=audio-oscillator) 10:57:49 INFO - PROCESS | 29776 | RSS: Main: 172498944 10:57:49 INFO - PROCESS | 29776 | 10:57:51 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:57:52 INFO - PROCESS | 29776 | RSS: Main: 177065984 10:57:52 INFO - PROCESS | 29776 | 10:57:55 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39106/tests/kraken/driver.html?testName=imaging-darkroom) 10:57:55 INFO - PROCESS | 29776 | RSS: Main: 213188608 10:57:55 INFO - PROCESS | 29776 | 10:57:59 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39106/tests/kraken/driver.html?testName=imaging-desaturate) 10:57:59 INFO - PROCESS | 29776 | RSS: Main: 213778432 10:57:59 INFO - PROCESS | 29776 | 10:58:02 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39106/tests/kraken/driver.html?testName=json-parse-financial) 10:58:03 INFO - PROCESS | 29776 | RSS: Main: 213704704 10:58:03 INFO - PROCESS | 29776 | 10:58:04 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:58:05 INFO - PROCESS | 29776 | RSS: Main: 200597504 10:58:05 INFO - PROCESS | 29776 | 10:58:07 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:58:07 INFO - PROCESS | 29776 | RSS: Main: 205119488 10:58:07 INFO - PROCESS | 29776 | 10:58:09 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:58:10 INFO - PROCESS | 29776 | RSS: Main: 219418624 10:58:10 INFO - PROCESS | 29776 | 10:58:12 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:58:13 INFO - PROCESS | 29776 | RSS: Main: 223928320 10:58:13 INFO - PROCESS | 29776 | 10:58:16 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:58:16 INFO - PROCESS | 29776 | RSS: Main: 217608192 10:58:16 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | Cycle 1(1): loaded http://localhost:39106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39106/tests/kraken/driver.html?testName=ai-astar) 10:58:18 INFO - PROCESS | 29776 | RSS: Main: 282107904 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | __start_tp_report 10:58:18 INFO - PROCESS | 29776 | _x_x_mozilla_page_load 10:58:18 INFO - PROCESS | 29776 | _x_x_mozilla_page_load_details 10:58:18 INFO - PROCESS | 29776 | |i|pagename|runs| 10:58:18 INFO - PROCESS | 29776 | |0;ai-astar;109;112;106;111;111;111;99;111;111;110 10:58:18 INFO - PROCESS | 29776 | |1;audio-beat-detection;157;135;166;194;129;159;165;129;203;126 10:58:18 INFO - PROCESS | 29776 | |2;audio-dft;160;160;160;160;159;160;162;159;160;160 10:58:18 INFO - PROCESS | 29776 | |3;audio-fft;73;77;103;104;77;72;75;133;104;73 10:58:18 INFO - PROCESS | 29776 | |4;audio-oscillator;92;93;151;93;92;92;146;92;92;146 10:58:18 INFO - PROCESS | 29776 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;117;117;116 10:58:18 INFO - PROCESS | 29776 | |6;imaging-darkroom;147;151;148;146;146;146;146;146;146;146 10:58:18 INFO - PROCESS | 29776 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;94;95 10:58:18 INFO - PROCESS | 29776 | |8;json-parse-financial;59;59;58;56;60;56;57;81;55;54 10:58:18 INFO - PROCESS | 29776 | |9;json-stringify-tinderbox;61;60;60;61;61;61;60;62;61;61 10:58:18 INFO - PROCESS | 29776 | |10;stanford-crypto-aes;77;77;76;82;76;76;76;77;77;87 10:58:18 INFO - PROCESS | 29776 | |11;stanford-crypto-ccm;128;135;124;125;124;123;124;125;161;127 10:58:18 INFO - PROCESS | 29776 | |12;stanford-crypto-pbkdf2;166;166;171;167;165;165;165;170;165;163 10:58:18 INFO - PROCESS | 29776 | |13;stanford-crypto-sha256-iterative;68;68;68;68;67;68;78;69;68;68 10:58:18 INFO - PROCESS | 29776 | __end_tp_report 10:58:18 INFO - PROCESS | 29776 | __start_cc_report 10:58:18 INFO - PROCESS | 29776 | _x_x_mozilla_cycle_collect,1631 10:58:18 INFO - PROCESS | 29776 | __end_cc_report 10:58:18 INFO - PROCESS | 29776 | __startTimestamp1461261498835__endTimestamp 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | ------- Summary: start ------- 10:58:18 INFO - PROCESS | 29776 | Number of tests: 14 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.93 (3.5%) stddev-sans-first:4.17 10:58:18 INFO - PROCESS | 29776 | Values: 109.0 112.0 106.0 111.0 111.0 111.0 99.0 111.0 111.0 110.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:162.00 stddev:27.17 (16.8%) stddev-sans-first:28.81 10:58:18 INFO - PROCESS | 29776 | Values: 157.0 135.0 166.0 194.0 129.0 159.0 165.0 129.0 203.0 126.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 10:58:18 INFO - PROCESS | 29776 | Values: 160.0 160.0 160.0 160.0 159.0 160.0 162.0 159.0 160.0 160.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#3] audio-fft Cycles:10 Average:89.10 Median:73.00 stddev:20.73 (28.4%) stddev-sans-first:21.15 10:58:18 INFO - PROCESS | 29776 | Values: 73.0 77.0 103.0 104.0 77.0 72.0 75.0 133.0 104.0 73.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:26.79 (29.1%) stddev-sans-first:27.71 10:58:18 INFO - PROCESS | 29776 | Values: 92.0 93.0 151.0 93.0 92.0 92.0 146.0 92.0 92.0 146.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 10:58:18 INFO - PROCESS | 29776 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.00 stddev:1.62 (1.1%) stddev-sans-first:1.72 10:58:18 INFO - PROCESS | 29776 | Values: 147.0 151.0 148.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 10:58:18 INFO - PROCESS | 29776 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:58.50 stddev:7.79 (13.3%) stddev-sans-first:8.26 10:58:18 INFO - PROCESS | 29776 | Values: 59.0 59.0 58.0 56.0 60.0 56.0 57.0 81.0 55.0 54.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 10:58:18 INFO - PROCESS | 29776 | Values: 61.0 60.0 60.0 61.0 61.0 61.0 60.0 62.0 61.0 61.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.00 stddev:3.60 (4.7%) stddev-sans-first:3.80 10:58:18 INFO - PROCESS | 29776 | Values: 77.0 77.0 76.0 82.0 76.0 76.0 76.0 77.0 77.0 87.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:126.00 stddev:11.57 (9.2%) stddev-sans-first:12.26 10:58:18 INFO - PROCESS | 29776 | Values: 128.0 135.0 124.0 125.0 124.0 123.0 124.0 125.0 161.0 127.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.00 stddev:2.45 (1.5%) stddev-sans-first:2.60 10:58:18 INFO - PROCESS | 29776 | Values: 166.0 166.0 171.0 167.0 165.0 165.0 165.0 170.0 165.0 163.0 10:58:18 INFO - PROCESS | 29776 | 10:58:18 INFO - PROCESS | 29776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.00 stddev:3.20 (4.7%) stddev-sans-first:3.37 10:58:18 INFO - PROCESS | 29776 | Values: 68.0 68.0 68.0 68.0 67.0 68.0 78.0 69.0 68.0 68.0 10:58:18 INFO - PROCESS | 29776 | -------- Summary: end -------- 10:58:18 INFO - PROCESS | 29776 | 10:58:19 INFO - TEST-INFO | 29776: exit 0 10:58:19 INFO - TEST-OK | kraken | took 60812ms 10:58:19 INFO - SUITE-END | took 1173s 10:58:19 INFO - Completed test suite (00:19:33) 10:58:19 INFO - javascript benchmark 10:58:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.908022759317, 3122.3755248950215, 3156.40028394605, 3157.8105313681167, 3181.570487984123, 5080.542751152396, 5134.229865520174, 5143.35708036495, 5153.098207813627, 5157.819476318325, 5164.044651739431, 5195.532402083812, 5214.296070030545, 5239.476052394759, 5255.579553635709, 4590.426196725392, 4642.5821676049145, 4761.928571071419, 4803.5676789088975, 4817.108834865561, 4752.738599377033, 4778.402699662543, 4797.9760101199445, 4803.159447096761, 4862.149123903303, 4618.122556714214, 4650.697704649204, 4663.603593694523, 4668.6265098792355, 4736.4789873114105, 4587.495375508692, 4594.517575654541, 4600.6549508786975, 4609.746463944482, 4636.327732478771, 4561.0, 4575.931361029554, 4580.541945805426, 4590.931136032962, 4622.953770462286, 5108.693478391271, 5165.483451654842, 5202.843914682566, 5206.193040078794, 5236.3978142513715, 5477.890442191174, 5493.093639549469, 5498.945010549924, 5500.42245564218, 5503.889922201573, 5450.727463626803, 5526.613137080406, 5532.834014979557, 5543.833684989457, 5544.695041772701, 5126.897462050775, 5141.434442211354, 5146.30524879144, 5160.509751573594, 5187.870303242449, 5586.0, 5587.106063029895, 5588.0, 5588.0779671354585, 5648.5481161507805, 5340.546053585411, 5346.599005074635, 5361.973190134025, 5371.650842695212, 5427.83716488506, 5504.889902202013, 5521.420250873601, 5523.088690366125, 5525.972370138124, 5537.307836520435, 5466.262054622575, 5481.534069604048, 5481.725913704378, 5486.890262194734, 5528.917066244009, 5361.946380536223, 5390.622656414092, 5401.918971215435, 5463.399026107125, 5463.48096930791, 4228.471441069866, 4230.0, 4233.97883010583, 4239.427677263591, 4273.444452221192, 3802.0, 3810.6379893910034, 3815.561210460777, 3822.4648549203134, 3838.2707285615643, 5144.948550514522, 5247.344081989751, 5277.709725965109, 5317.813876514303, 5319.46805319465, 5381.48875856793, 5388.326459192601, 5395.595330350239, 5405.486478784509, 5428.104362780176, 5124.871878203075, 5163.044836705221, 5182.404023537341, 5186.481351864783, 5246.842594722164, 4841.636877234221, 4842.782074806642, 4849.660523763373, 4893.681910675866, 4903.803847846118, 5485.369182543979, 5632.183333416631, 5668.433156684381, 5680.346760122557, 5723.542116630742, 5324.733763311897, 5430.83707488776, 5430.968116058094, 5432.239486471818, 5530.668159910419, 5674.233978413026, 5692.31692196939, 5694.088945768657, 5740.799072032459, 5744.597878148489, 5366.919496207482, 5368.0, 5369.301990741179, 5372.167314066326, 5380.300560927054, 5399.730013499231, 5437.755301011543, 5479.589030822784, 5500.037493438552, 5503.257060296809, 5364.919526207032, 5374.355077390738, 5376.946230537645, 5382.623216374973, 5423.457654234545, 5345.625806193529, 5349.679019258857, 5350.3312085989255, 5364.0, 5400.378956420062, 5167.560757335668, 5176.0, 5270.262163297065, 5272.525472707474, 5289.841304760864, 5416.864578385572, 5436.592255580927, 5441.129419292894, 5445.319335083114, 5452.809151679672, 5347.090994531017, 5347.973260133675, 5356.839294821161, 5359.356877174764, 5397.730113494231], "value": 5080.165543027579, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2404232687978, 625.7246811402986, 635.7615894039735, 654.9410553050221, 657.021038652408, 29976.25059373514, 36922.63077369225, 37806.62193378062, 37871.810640946824, 37933.0, 39158.608413915856, 39492.60507394932, 39848.80075599625, 39875.0, 39937.201255974935, 7391.778246652582, 8425.494470331769, 8635.568221588926, 8641.52471614061, 9727.464989425578, 9739.464329461876, 9928.702138935843, 9930.05664461875, 9930.851037234448, 9936.652217172401, 10207.285490015665, 10308.48457577122, 10327.27709060366, 10406.531706073245, 10419.218558608096, 7540.396768258526, 7854.8429031419055, 10177.338472999232, 10290.7427314317, 10542.15662746986, 9971.451570163637, 10107.89892101077, 10111.696649100466, 10118.54466549007, 10121.746956326151, 36440.63559364399, 37062.923078461616, 37096.44355334672, 37130.443043354375, 37133.44299835504, 3633.1643721943838, 3774.0942173878348, 4120.690948178899, 4147.979260103711, 4195.7063005589625, 31138.377232455452, 31448.842755786074, 31558.526622100686, 31588.684113158804, 31832.363352732817, 4187.937180942288, 4255.63827074699, 4310.4396428464415, 4376.212281789277, 4445.688801783876, 280930.0, 282558.0, 283236.0, 283494.0, 283993.0, 57842.7107864458, 58224.0, 58248.0, 58272.0, 58399.0, 54119.72940135353, 54211.72894135504, 54287.18569221465, 54301.72849135808, 54328.45671543313, 16829.747553786703, 17044.914775426045, 17082.658346833243, 17128.0, 17142.40001599938, 13302.401391937387, 13374.598762037154, 13377.197368157942, 13378.197308161542, 13382.13016153947, 15341.539753807403, 16820.495385138467, 16863.494095177164, 16878.156092195342, 16892.0, 5171.4311425743135, 6105.450509454082, 6140.4473597376455, 6276.529260305495, 6305.8108256752375, 996.3858549150278, 1098.2531878322657, 1102.7022703869911, 1109.5007246738999, 1142.994285028586, 29533.704662953096, 30682.53976190359, 30847.537286940715, 30917.38165236683, 31355.84322078375, 1105.1490352428584, 1125.7354521687396, 1132.2357408749062, 1156.67613068341, 1233.3031837012059, 16285.185740712917, 16326.0, 16361.509154725378, 16556.50330490087, 16659.00045997244, 401587.0, 521608.0, 534098.0, 535839.0, 537131.0, 55452.0, 55915.72042139763, 56209.31372058845, 56244.0, 56312.43687563154, 1253.692845252919, 1319.7426501832242, 1408.4295860176644, 1422.5732280315865, 1498.7676910078956, 29836.0, 31195.0, 31825.5226171603, 31896.840515797274, 31978.0, 45264.77367613141, 53425.0, 56169.43830561642, 56288.15567766405, 56290.718546407006, 241564.0, 243077.0, 243445.0, 244953.0, 246008.0, 24990.625140622542, 27422.862885685445, 27435.588466173424, 27847.86076069607, 27878.721212787612, 41188.38217426801, 42174.578254217064, 42471.0, 46706.53293467158, 46807.29789053099, 36782.26435471222, 38882.2223555533, 39251.93572351011, 39349.0, 40429.59570404376, 37668.06733185676, 38173.857294084584, 39019.6098039016, 39092.218155637296, 39802.402963954984, 39237.607623923395, 39632.2073558533, 39911.40132898067, 40316.79841600773, 40367.3944890821, 34027.4895876567, 34585.65414345825, 34925.82537087298, 35127.29745405129, 35321.64678353183, 27102.0, 27385.726142739113, 27404.862975684995, 27481.587776182972, 28039.43921121607], "value": 19351.02685120529, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.757110591433, 395.3575439910145, 402.09127372138977, 405.9167870586529, 411.13866449787685, 13814.585562433143, 15015.774763378531, 16649.16754162293, 17616.55958601034, 17651.646967060668, 16688.83311166888, 17215.22531486083, 17504.824951750477, 17521.123943802824, 18677.159527821248, 5553.8333849984565, 5666.065099258617, 5699.316082070137, 5721.942780572203, 5726.198332233491, 3974.085960229149, 5658.830235092933, 5708.172315014321, 5886.6468011919205, 6262.342454042328, 6192.071189321593, 6195.163652906867, 6212.099245609384, 6230.439260466557, 6236.158118653969, 5998.1602575639445, 6095.3599872013465, 6174.938250617503, 6178.042403427476, 6291.937080629181, 5347.866303342447, 5547.3343198816, 5547.972260138674, 5553.305836770403, 5554.028045092133, 11842.940785296018, 12508.3745812709, 22045.448863778533, 22145.44636384087, 22177.55644887093, 2327.5344931013865, 2415.951680966371, 2439.0853429963763, 2777.486897941085, 2933.7799665024995, 9104.31717621181, 9399.812003759955, 9564.18704410126, 9576.377535460173, 9771.364861283993, 1904.438190733737, 1927.267638297438, 1944.8638595298335, 1972.4674337928823, 1986.8807871527754, 51671.48328516742, 53799.0, 54079.72960135213, 63022.99999999954, 75908.24091759067, 10134.290599657954, 10418.895811041793, 10656.4300959178, 10988.066014388867, 11006.889931100746, 14960.551183464513, 15078.472253471076, 15111.0, 15136.621584460256, 15183.316750746242, 8067.435279530494, 8125.9187408126345, 8224.424290299741, 8251.381146413923, 8307.792305192419, 7685.846283074307, 7693.1922148173635, 8048.59757012147, 8125.228103330174, 8231.547264900488, 4586.6789324747615, 4630.768461576908, 4645.790939407667, 4687.81248750053, 4716.127516409475, 1731.0, 1828.7714035745532, 1888.6222755448964, 1906.752122224102, 1925.9037048147536, 999.5901680311038, 1024.9436281004616, 1093.868735751715, 1108.2766298405895, 1157.479134389528, 17082.829171708123, 17561.648767024588, 18505.629887402178, 18512.611554133495, 19123.139458724112, 1026.645807196516, 1048.2819268800895, 1051.9789604207872, 1057.2440704895882, 1101.5043230546287, 9961.153301969269, 10277.229207809443, 10278.201314769885, 10296.639617613497, 10421.53103110362, 337070.0, 337396.0, 337742.0, 339888.0, 450392.0, 85966.57016714876, 91986.54006729924, 92193.15613687823, 92568.0, 93182.0, 983.7786498037884, 1053.373242920461, 1063.1123012284675, 1107.2692023264606, 1108.6275370706694, 15696.686066278839, 15697.529074127795, 15702.21488925572, 15901.60245993813, 15933.68132637364, 32604.0, 32932.67067329296, 34224.0, 34525.65474345224, 36252.27495450129, 50028.0, 51152.74423627858, 53089.0, 53234.0, 53849.19226211531, 7620.428467864822, 7927.165442326827, 8066.354691624539, 8070.314023308085, 8258.091609923023, 12334.691632709255, 12362.938185309016, 12485.375731213222, 12736.490540378281, 12774.552890648783, 11155.665330040112, 11426.314421134759, 11600.825987610362, 11664.241824281735, 11923.582674606347, 10982.165586020014, 11064.446777661246, 11192.552297908318, 11424.371659558805, 11882.10884183707, 11294.265872718248, 11515.25150865191, 11603.883961160618, 11785.057195424517, 11873.881261187624, 8056.798580035312, 8146.83706325882, 8358.791030224049, 8434.662613495391, 8502.319814414956, 9722.80554388894, 11238.15713821483, 11259.49332280033, 11331.546738130382, 11382.54469821198], "value": 8801.617718297744, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.0359712230213, 1527.8319384867666, 1557.4626753769946, 1721.1824383417877, 1817.4002579148873, 7573.166951635316, 7865.724699635514, 7885.921140788598, 7906.92093079069, 7918.0, 7702.576358300291, 7839.764807055783, 7862.606869656509, 7863.331616812564, 7870.055593328794, 1932.7680678318552, 1990.5222746540799, 2139.2619546256515, 2164.7835216478306, 2189.025883481851, 2253.695751073609, 2272.0457407888644, 2274.5109801392696, 2275.488015196576, 2278.624027035537, 2191.9780802191935, 2203.8126759225484, 2228.2869481765842, 2230.185982116524, 2232.866028038323, 1854.8516118710538, 1924.490010147312, 2095.4656562576447, 2169.229923377194, 2173.6956826044366, 2229.0637932068407, 2243.6298010828195, 2246.427161073932, 2247.314569056437, 2249.7975182233677, 7896.921030789734, 7936.047674279123, 7941.126476087626, 7955.204479551999, 7957.124716281204, 4535.138323718483, 4664.160451118797, 4667.603253723438, 4685.929711054337, 4701.294805779126, 2988.6114805075417, 3179.952300715491, 3191.0745883693703, 3197.2646291353117, 3197.6162860456893, 2072.336852207294, 2128.0, 2129.659254519285, 2130.126648074282, 2131.1475409836034, 10893.455327233685, 10997.560097596086, 10999.175061870392, 10999.505022274017, 11003.33979961205, 4043.2317859606583, 4057.4928133983253, 4082.142750022469, 4092.7339722917914, 4093.3041382964966, 8784.0, 8785.560721964004, 8805.295576353876, 8941.687040953666, 8982.730518084338, 4796.8081276748535, 4817.662763606584, 4820.493848145964, 4828.493008234155, 4837.4920633332995, 4005.1388951375593, 4314.913701725948, 4421.690481666316, 4429.7120687155875, 4430.468343798765, 3500.4749287607065, 3534.681878630884, 3549.378858699717, 3573.2317551726505, 3638.381475149178, 1025.74869157057, 1033.5865653738565, 1034.0486752188006, 1047.8323468245044, 1060.8461773042866, 803.9879401808978, 949.6486300069018, 959.4531117263093, 966.0580933589835, 986.146982859821, 5472.2065300531995, 5481.287432633732, 5593.356763972114, 5649.858753531113, 5759.596828222068, 916.1617120334952, 946.0823001688351, 949.5916755794937, 993.4486360070231, 1018.4398580780542, 3741.8877433677035, 3753.4557489163917, 3827.349350610403, 3832.6358995895343, 3861.1119442528375, 9367.531623418801, 9455.243580513543, 9714.319997600242, 9816.0, 9843.261755368376, 9598.472084035446, 9647.71056868295, 9742.853857192147, 9754.317197796228, 9772.951135244279, 7397.0, 7443.069616297963, 7483.13943896448, 7640.388768898586, 7671.194524574951, 5744.454276843693, 5770.942290577041, 5828.76684932598, 5854.94145058561, 5862.853428664147, 9154.084591540792, 9319.207867331354, 9385.718428447157, 9401.670941517013, 9464.290178236522, 9062.637494500146, 9437.764055898657, 9474.810503790024, 9530.904690953279, 9672.129508344282, 6542.640154791342, 6987.301269872972, 7037.472189585699, 7148.0, 7175.748848790267, 7865.252800983897, 7903.525788452711, 7957.602119893866, 7965.681372745025, 7969.242921922408, 6834.794956151323, 7120.216776154515, 7137.179224389261, 7226.963865180641, 7275.163356214103, 6965.79102626922, 7135.143782746104, 7156.177039640508, 7244.166920803964, 7296.379807716404, 6230.314665386894, 6339.1125242467015, 6343.746250149942, 6344.841378965562, 6353.301136875032, 4738.573528382462, 4768.856934291976, 4809.2064809306075, 4879.926801097916, 4917.360743103373, 4740.976295118502, 4795.520447955177, 4842.757862106951, 4934.481879402611, 4943.456219815889], "value": 4354.502490370196, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.6538997457937, 312.63421796498096, 314.61412478034254, 324.7272291275329, 326.83821508353367, 5395.7032363220005, 5536.169574563817, 5536.4186760390185, 5621.4940655341015, 5652.180433837097, 5507.862303442406, 5512.448755124496, 5531.834044978647, 5555.2778138841995, 5602.355729091156, 4332.111917057004, 4332.978335108336, 4333.706383148814, 4345.065810850667, 4346.022974262624, 4035.354343305072, 4165.937510937339, 4304.203722311367, 4330.631896288819, 4345.804438800262, 4251.107267473834, 4281.529031806499, 4299.828586563796, 4304.31131019037, 4314.784260786963, 4246.341817018367, 4248.171606536726, 4275.572442755731, 4275.743455392686, 4290.892727681801, 3646.32542979547, 3771.811409429545, 3774.037620406806, 3782.451544526028, 3784.4701741756176, 5284.762185701653, 5340.519353258225, 5351.0, 5356.303680521546, 5370.194470829368, 4884.5848102911295, 4888.511148885119, 4891.75541222941, 4895.804167833318, 4896.706197628154, 5665.49010589049, 5730.02038939749, 5788.176724331822, 5800.389824578914, 5825.563082768809, 4101.97949010256, 4129.318662420697, 4130.277201489727, 4132.752034877887, 4136.669066474675, 6099.207103076572, 6115.388461153849, 6115.737177244404, 6137.6624285664275, 6138.8772224555705, 4137.565555616678, 4223.767692776865, 4234.237837189274, 4234.851780187679, 4244.0663054128045, 4239.533651298355, 4244.3209086546, 4251.383549385322, 4255.340422234559, 4279.101388708406, 4863.416390033219, 4884.462709101996, 4886.120498310267, 4886.267059941038, 4886.755662216875, 5622.762992141722, 5796.449337312949, 5801.622894511843, 5861.6189947653265, 5869.090291004901, 1350.9662258443618, 1396.4484028808563, 1441.5891470930735, 1442.4662874736205, 1447.6959838433836, 944.419182202954, 949.928755343352, 952.5761036338902, 966.8453047512364, 969.0793745941384, 5632.887342253214, 5641.605087643908, 5643.830685079454, 5646.20953066571, 5653.802116925888, 5888.764449422061, 5889.882202355929, 5911.852203694856, 5915.077599780003, 5944.316403613553, 5485.369182543979, 5667.348254950651, 5674.432556744293, 5784.971075144597, 5837.9124313135335, 3243.1729908873085, 3264.922575550063, 3270.1824543864036, 3271.7219036382176, 3274.672532746754, 6222.937770622327, 6344.809655710336, 6392.648404337713, 6396.744130234739, 6421.967890160519, 6204.565680402328, 6224.470919971763, 6225.782097626561, 6237.313895471494, 6246.501958903029, 6317.3366796486625, 6317.905231421624, 6318.6524741138755, 6329.398707122816, 6356.555041147168, 5886.646801191942, 6085.57400981927, 6087.908681369871, 6089.177960975212, 6113.29697084841, 5908.763649453974, 5909.261342332208, 5913.231279933581, 5934.406559344031, 5971.4327138921735, 6158.969205153946, 6350.396712312323, 6352.491800656029, 6356.396142366468, 6376.234851817811, 4034.314166591628, 4037.2329257440992, 4039.4546736191414, 4061.329880569791, 4068.14568940514, 5770.336411312753, 6051.273847138372, 6080.300765412034, 6088.786892458743, 6112.694365281807, 5608.040897326179, 5760.107183386582, 5760.6255593386295, 5779.450952159538, 5819.738111785065, 5886.646801191942, 5898.174255604305, 5902.52094120479, 5929.644221346733, 5943.375945525658, 5674.0565307111165, 5725.0, 5770.172615418331, 5781.739821708117, 5827.125931110198, 5928.584999050025, 5934.495567876779, 5942.732577033958, 5949.791757288474, 5964.451151564812, 5799.884002320015, 5827.475527202572, 5831.650100993784, 5832.212651292191, 5842.591018628656], "value": 4429.8860557206335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.458322508443, 836.7531578184436, 843.5444859775721, 860.0539406652679, 863.2230992107103, 13037.869621303784, 13187.604371868836, 13215.471381144742, 13218.867811321885, 13232.73534529309, 13311.134776239538, 13371.732565348711, 13379.59861204163, 13398.866011339884, 13424.261665608388, 651.9054737063111, 775.2634996753108, 814.2305521282391, 825.9008918929707, 826.8759686047081, 821.8602837517636, 827.983440331193, 828.5981299069946, 828.9792755181138, 829.6681327469, 704.6511976571578, 883.9513826739527, 887.5917078144062, 887.6981826179098, 887.951162686052, 720.895470156827, 723.0600219714377, 860.1957170045996, 888.2849306308419, 889.888763904512, 622.483338828771, 622.5019984012772, 625.8122563231012, 626.1859582542676, 626.3767551286454, 13167.934160329232, 13170.407331670098, 13186.274754888478, 13188.736225275441, 13255.27096009719, 13786.862131378759, 13839.861601383958, 13963.860361396357, 13989.510367137204, 14080.92959535206, 10498.790024199474, 10533.315334503233, 10550.314229575053, 10594.25840191187, 10651.786964260671, 3889.2610404023426, 3910.569837317893, 3936.7637941723588, 3975.662068724162, 3980.5820388859333, 54455.72772136154, 55026.0, 55902.16146757802, 56252.71873640606, 56442.71778641122, 11054.668359949053, 11110.111191104692, 11240.0, 11278.774424511465, 11350.432478376048, 20407.387778366672, 20427.8978605109, 20461.590768184553, 20472.488187795127, 20495.692564611243, 7940.364770818321, 7978.361731061501, 7983.640736166886, 8013.398995075276, 8248.340132789363, 4577.0, 4611.239145541015, 4696.9060618787435, 4712.52874712526, 4765.380500534909, 3355.949660755042, 3422.0418282880833, 3427.8114703691535, 3439.3121375724954, 3445.707114895212, 594.9855496378664, 628.7516431009725, 633.1357696744003, 645.3739872323838, 652.2043107408954, 659.0, 724.1816747075876, 742.8959945607619, 755.833716582351, 773.7601343583507, 8160.102388737234, 8629.870551941725, 8866.73399798007, 8887.511186884783, 8958.596863141174, 713.4114355656604, 719.1873183302835, 719.597025665629, 739.4084732214208, 746.0972223609493, 4252.277112890816, 4322.15717935006, 4436.0906014267, 4495.662825288116, 4541.750203738826, 52023.0, 61444.0, 63102.68448657727, 63569.04646430307, 63683.681581591794, 44635.77682111569, 45565.77217113893, 45683.5431645686, 46129.308060379124, 46735.29897051547, 44376.0, 45828.0, 46322.768386158525, 47363.05273894503, 47607.76196119066, 8719.694810681596, 8810.603522841358, 8838.911610884066, 8982.281417486716, 8988.86516702263, 30338.696613033586, 30936.84531577418, 31168.844155779076, 31399.84300078485, 31666.208344791565, 40816.591834082465, 41053.0, 41455.7927210362, 43443.13113737644, 44964.0, 12244.265344079384, 12334.198277112318, 12415.75168496607, 12436.19164754288, 12616.053795965523, 13551.390187441786, 13563.525276615272, 13861.37623806911, 14045.157290562598, 14161.787573186204, 11540.192186546861, 11580.710482238012, 11708.941455292668, 12905.225686458842, 13170.934145329595, 12323.75352492963, 12792.61622151337, 12995.935020324838, 13374.06381553282, 13410.39653215588, 12079.39603019863, 12084.939575302067, 12115.0, 12184.329861857683, 12193.69515762113, 10478.0, 10706.143508519144, 10780.568777248822, 10797.352158870493, 10852.891471085188, 10742.462876855969, 10874.130069594572, 10952.507137178687, 11082.16883733707, 11145.498452569816], "value": 6633.193585342865, "unit": "score"}], "name": "dromaeo_css", "value": 6929.583049238506, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 106.0, 111.0, 111.0, 111.0, 99.0, 111.0, 111.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 166.0, 194.0, 129.0, 159.0, 165.0, 129.0, 203.0, 126.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 159.0, 160.0, 162.0, 159.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 103.0, 104.0, 77.0, 72.0, 75.0, 133.0, 104.0, 73.0], "value": 89.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 151.0, 93.0, 92.0, 92.0, 146.0, 92.0, 92.0, 146.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 56.0, 60.0, 56.0, 57.0, 81.0, 55.0, 54.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 82.0, 76.0, 76.0, 76.0, 77.0, 77.0, 87.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 135.0, 124.0, 125.0, 124.0, 123.0, 124.0, 125.0, 161.0, 127.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 171.0, 167.0, 165.0, 165.0, 165.0, 170.0, 165.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 78.0, 69.0, 68.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1545.0999999999997, "alertThreshold": 2.0}]} 10:58:20 INFO - Return code: 0 10:58:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:58:20 ERROR - # TBPL SUCCESS # 10:58:20 INFO - Running post-action listener: _resource_record_post_action 10:58:20 INFO - Running post-run listener: _resource_record_post_run 10:58:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 16384; Write bytes: 535617536; Read time: 424; Write time: 647492 10:58:21 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 244838400; Read time: 204; Write time: 385488 10:58:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 290779136; Read time: 220; Write time: 262004 10:58:21 INFO - Running post-run listener: _upload_blobber_files 10:58:21 INFO - Blob upload gear active. 10:58:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:58:21 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 10:58:21 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'] 10:58:21 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 10:58:21 INFO - (blobuploader) - INFO - Open directory for files ... 10:58:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:58:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:58:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:22 INFO - (blobuploader) - INFO - Done attempting. 10:58:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:58:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:23 INFO - (blobuploader) - INFO - Done attempting. 10:58:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:58:23 INFO - Return code: 0 10:58:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:58:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:58:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f7fc62f0592052bea21d82f40c14e1dfc670381442a78f76a1b3639e9f03c3fe32644497589c7f68551715f3d2d9b56c2af6c0cc6762865a1398b14ec87a3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8010433c7d27ef1d88cc30e798b9d12d804e8d6516f899b488fd5790c96e3f635e14f0da752f04a59098351722e3202cb96f0ef35cb52d92bb5eaba4a051c3"} 10:58:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:58:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:58:23 INFO - Contents: 10:58:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1f7fc62f0592052bea21d82f40c14e1dfc670381442a78f76a1b3639e9f03c3fe32644497589c7f68551715f3d2d9b56c2af6c0cc6762865a1398b14ec87a3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8010433c7d27ef1d88cc30e798b9d12d804e8d6516f899b488fd5790c96e3f635e14f0da752f04a59098351722e3202cb96f0ef35cb52d92bb5eaba4a051c3"} 10:58:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:58:23 INFO - Copying logs to upload dir... 10:58:23 INFO - mkdir: /builds/slave/test/build/upload/logs 10:58:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.930797 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-04-21 10:58:23.588551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:58:23.592376) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760 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/1f7fc62f0592052bea21d82f40c14e1dfc670381442a78f76a1b3639e9f03c3fe32644497589c7f68551715f3d2d9b56c2af6c0cc6762865a1398b14ec87a3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8010433c7d27ef1d88cc30e798b9d12d804e8d6516f899b488fd5790c96e3f635e14f0da752f04a59098351722e3202cb96f0ef35cb52d92bb5eaba4a051c3"} build_url:https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/ZrHbXmnmTWS07sbE3xaSvA/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/1f7fc62f0592052bea21d82f40c14e1dfc670381442a78f76a1b3639e9f03c3fe32644497589c7f68551715f3d2d9b56c2af6c0cc6762865a1398b14ec87a3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c8010433c7d27ef1d88cc30e798b9d12d804e8d6516f899b488fd5790c96e3f635e14f0da752f04a59098351722e3202cb96f0ef35cb52d92bb5eaba4a051c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 10:58:23.619953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:58:23.620332) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461260272.120381-1045441760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 10:58:23.704164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:58:23.704510) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 10:58:23.704843) ========= ========= Total master_lag: 0.17 =========