builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1461679046.48 results: success (0) buildid: 20160426061007 builduid: a96f73bf00b941b19450a2b177860452 revision: e51ba816be5f43ce0cfd0d204247473122c9951f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.479782) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.480452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.480951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.500911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.501273) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-26 06:57:27-- 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% 101M=0s 2016-04-26 06:57:27 (101 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.679995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.680384) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.729512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:26.729872) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e51ba816be5f43ce0cfd0d204247473122c9951f --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 e51ba816be5f43ce0cfd0d204247473122c9951f --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=74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-26 06:57:27,476 truncating revision to first 12 chars 2016-04-26 06:57:27,476 Setting DEBUG logging. 2016-04-26 06:57:27,476 attempt 1/10 2016-04-26 06:57:27,476 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e51ba816be5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-26 06:57:28,095 unpacking tar archive at: fx-team-e51ba816be5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.886977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:27.629755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:27.630157) ========= script_repo_revision: e51ba816be5f43ce0cfd0d204247473122c9951f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:27.630581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:27.630865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-26 06:57:27.640933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-26 06:57:27.641329) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:28 INFO - MultiFileLogger online at 20160426 06:57:28 in /builds/slave/test 06:57:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:57:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:28 INFO - {'append_to_log': False, 06:57:28 INFO - 'base_work_dir': '/builds/slave/test', 06:57:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:57:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:28 INFO - 'branch': 'Fx-Team-Non-PGO', 06:57:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:28 INFO - 'config_files': ('talos/linux_config.py',), 06:57:28 INFO - 'default_actions': ('clobber', 06:57:28 INFO - 'read-buildbot-config', 06:57:28 INFO - 'download-and-extract', 06:57:28 INFO - 'populate-webroot', 06:57:28 INFO - 'create-virtualenv', 06:57:28 INFO - 'install', 06:57:28 INFO - 'run-tests'), 06:57:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:28 INFO - 'download_minidump_stackwalk': True, 06:57:28 INFO - 'download_symbols': 'ondemand', 06:57:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:28 INFO - 'installer_path': 'installer.exe', 06:57:28 INFO - 'log_level': 'info', 06:57:28 INFO - 'log_name': 'talos', 06:57:28 INFO - 'log_to_console': True, 06:57:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:28 INFO - 'opt_config_files': (), 06:57:28 INFO - 'pip_index': False, 06:57:28 INFO - 'sps_profile': False, 06:57:28 INFO - 'sps_profile_interval': 0, 06:57:28 INFO - 'suite': 'dromaeojs', 06:57:28 INFO - 'system_bits': '32', 06:57:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:28 INFO - 'title': 'talos-linux64-ix-042', 06:57:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:28 INFO - 'use_talos_json': True, 06:57:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:28 INFO - 'work_dir': 'build'} 06:57:28 INFO - ##### 06:57:28 INFO - ##### Running clobber step. 06:57:28 INFO - ##### 06:57:28 INFO - Running pre-action listener: _resource_record_pre_action 06:57:28 INFO - Running main action method: clobber 06:57:28 INFO - rmtree: /builds/slave/test/build 06:57:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:29 INFO - Running post-action listener: _resource_record_post_action 06:57:29 INFO - ##### 06:57:29 INFO - ##### Running read-buildbot-config step. 06:57:29 INFO - ##### 06:57:29 INFO - Running pre-action listener: _resource_record_pre_action 06:57:29 INFO - Running main action method: read_buildbot_config 06:57:29 INFO - Using buildbot properties: 06:57:29 INFO - { 06:57:29 INFO - "project": "", 06:57:29 INFO - "product": "firefox", 06:57:29 INFO - "script_repo_revision": "production", 06:57:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:57:29 INFO - "repository": "", 06:57:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:57:29 INFO - "buildid": "20160426061007", 06:57:29 INFO - "pgo_build": "False", 06:57:29 INFO - "basedir": "/builds/slave/test", 06:57:29 INFO - "buildnumber": 2891, 06:57:29 INFO - "slavename": "talos-linux64-ix-042", 06:57:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:57:29 INFO - "platform": "ubuntu64_hw", 06:57:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:57:29 INFO - "branch": "fx-team", 06:57:29 INFO - "repo_path": "integration/fx-team", 06:57:29 INFO - "revision": "e51ba816be5f43ce0cfd0d204247473122c9951f", 06:57:29 INFO - "stage_platform": "linux64", 06:57:29 INFO - "builduid": "a96f73bf00b941b19450a2b177860452", 06:57:29 INFO - "slavebuilddir": "test" 06:57:29 INFO - } 06:57:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:57:29 INFO - Running post-action listener: _resource_record_post_action 06:57:29 INFO - ##### 06:57:29 INFO - ##### Running download-and-extract step. 06:57:29 INFO - ##### 06:57:29 INFO - Running pre-action listener: _resource_record_pre_action 06:57:29 INFO - Running main action method: download_and_extract 06:57:29 INFO - mkdir: /builds/slave/test/build/tests 06:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:29 INFO - https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:57:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:57:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:57:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:57:30 INFO - Downloaded 1361 bytes. 06:57:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:57:30 INFO - Using the following test package requirements: 06:57:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:57:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'jsshell-linux-x86_64.zip'], 06:57:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:57:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:57:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:30 INFO - https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:31 INFO - Downloaded 22291062 bytes. 06:57:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:32 INFO - Return code: 0 06:57:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:32 INFO - https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:33 INFO - Downloaded 22291062 bytes. 06:57:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:35 INFO - Return code: 0 06:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:35 INFO - https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:57:36 INFO - Downloaded 10840145 bytes. 06:57:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:57:36 INFO - Return code: 0 06:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:36 INFO - https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:57:38 INFO - Downloaded 54815722 bytes. 06:57:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:57:38 INFO - mkdir: /builds/slave/test/properties 06:57:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:57:38 INFO - Writing to file /builds/slave/test/properties/build_url 06:57:38 INFO - Contents: 06:57:38 INFO - build_url:https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:57:39 INFO - Running post-action listener: _resource_record_post_action 06:57:39 INFO - Running post-action listener: set_extra_try_arguments 06:57:39 INFO - ##### 06:57:39 INFO - ##### Running populate-webroot step. 06:57:39 INFO - ##### 06:57:39 INFO - Running pre-action listener: _resource_record_pre_action 06:57:39 INFO - Running main action method: populate_webroot 06:57:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:39 INFO - '--tppagecycles', 06:57:39 INFO - '7'], 06:57:39 INFO - 'tests': ['tsvgm']}}, 06:57:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:57:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:57:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:57:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['damp', 'tps']}, 06:57:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'tests': ['damp', 'tps']}, 06:57:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['dromaeo_dom']}, 06:57:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['a11yr', 06:57:39 INFO - 'ts_paint', 06:57:39 INFO - 'tpaint', 06:57:39 INFO - 'sessionrestore', 06:57:39 INFO - 'sessionrestore_no_auto_restore', 06:57:39 INFO - 'tabpaint']}, 06:57:39 INFO - 'other-e10s': {'tests': ['a11yr', 06:57:39 INFO - 'ts_paint', 06:57:39 INFO - 'tpaint', 06:57:39 INFO - 'sessionrestore', 06:57:39 INFO - 'sessionrestore_no_auto_restore', 06:57:39 INFO - 'tabpaint']}, 06:57:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:57:39 INFO - 'ts_paint', 06:57:39 INFO - 'tpaint', 06:57:39 INFO - 'sessionrestore', 06:57:39 INFO - 'sessionrestore_no_auto_restore', 06:57:39 INFO - 'tabpaint']}, 06:57:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:57:39 INFO - 'ts_paint', 06:57:39 INFO - 'tpaint', 06:57:39 INFO - 'sessionrestore', 06:57:39 INFO - 'sessionrestore_no_auto_restore', 06:57:39 INFO - 'tabpaint']}, 06:57:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['a11yr', 06:57:39 INFO - 'ts_paint', 06:57:39 INFO - 'tpaint', 06:57:39 INFO - 'sessionrestore', 06:57:39 INFO - 'sessionrestore_no_auto_restore', 06:57:39 INFO - 'tabpaint']}, 06:57:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['a11yr', 06:57:39 INFO - 'ts_paint', 06:57:39 INFO - 'tpaint', 06:57:39 INFO - 'sessionrestore', 06:57:39 INFO - 'sessionrestore_no_auto_restore', 06:57:39 INFO - 'tabpaint']}, 06:57:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['tsvgx', 06:57:39 INFO - 'tsvgr_opacity', 06:57:39 INFO - 'tart', 06:57:39 INFO - 'tscrollx', 06:57:39 INFO - 'cart']}, 06:57:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:57:39 INFO - 'tsvgr_opacity', 06:57:39 INFO - 'tart', 06:57:39 INFO - 'tscrollx', 06:57:39 INFO - 'cart']}, 06:57:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'talos_options': ['--disable-e10s'], 06:57:39 INFO - 'tests': ['tp5o']}, 06:57:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'tests': ['tp5o']}, 06:57:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'talos_options': ['--disable-e10s', 06:57:39 INFO - '--xperf_path', 06:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:39 INFO - 'tests': ['tp5n']}, 06:57:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:39 INFO - 'talos_options': ['--xperf_path', 06:57:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:39 INFO - 'tests': ['tp5n']}}, 06:57:39 INFO - 'talos.zip': {'path': '', 06:57:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:39 INFO - Running post-action listener: _resource_record_post_action 06:57:39 INFO - ##### 06:57:39 INFO - ##### Running create-virtualenv step. 06:57:39 INFO - ##### 06:57:39 INFO - Running pre-action listener: _resource_record_pre_action 06:57:39 INFO - Running main action method: create_virtualenv 06:57:39 INFO - Creating virtualenv /builds/slave/test/build/venv 06:57:39 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 06:57:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:57:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:39 INFO - Using real prefix '/usr' 06:57:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:57:40 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:42 INFO - Installing pip.................done. 06:57:42 INFO - Return code: 0 06:57:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:42 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 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:42 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 06:57:42 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 06:57:42 INFO - Using env: {'DISPLAY': ':0', 06:57:42 INFO - 'HOME': '/home/cltbld', 06:57:42 INFO - 'LANG': 'en_US.UTF-8', 06:57:42 INFO - 'LANGUAGE': 'en_US:en', 06:57:42 INFO - 'LOGNAME': 'cltbld', 06:57:42 INFO - 'MAIL': '/var/mail/cltbld', 06:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:42 INFO - 'MOZ_NO_REMOTE': '1', 06:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:42 INFO - 'NO_EM_RESTART': '1', 06:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:42 INFO - 'PWD': '/builds/slave/test', 06:57:42 INFO - 'SHELL': '/bin/bash', 06:57:42 INFO - 'SHLVL': '1', 06:57:42 INFO - 'TERM': 'linux', 06:57:42 INFO - 'TMOUT': '86400', 06:57:42 INFO - 'USER': 'cltbld', 06:57:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:42 INFO - '_': '/tools/buildbot/bin/python'} 06:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:42 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 06:57:42 INFO - Cleaning up... 06:57:42 INFO - Return code: 0 06:57:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:42 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 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:42 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 06:57:42 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 06:57:42 INFO - Using env: {'DISPLAY': ':0', 06:57:42 INFO - 'HOME': '/home/cltbld', 06:57:42 INFO - 'LANG': 'en_US.UTF-8', 06:57:42 INFO - 'LANGUAGE': 'en_US:en', 06:57:42 INFO - 'LOGNAME': 'cltbld', 06:57:42 INFO - 'MAIL': '/var/mail/cltbld', 06:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:42 INFO - 'MOZ_NO_REMOTE': '1', 06:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:42 INFO - 'NO_EM_RESTART': '1', 06:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:42 INFO - 'PWD': '/builds/slave/test', 06:57:42 INFO - 'SHELL': '/bin/bash', 06:57:42 INFO - 'SHLVL': '1', 06:57:42 INFO - 'TERM': 'linux', 06:57:42 INFO - 'TMOUT': '86400', 06:57:42 INFO - 'USER': 'cltbld', 06:57:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:42 INFO - '_': '/tools/buildbot/bin/python'} 06:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:42 INFO - Downloading/unpacking psutil>=0.7.1 06:57:42 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 06:57:42 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 06:57:42 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 06:57:42 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 06:57:42 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 06:57:42 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 06:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:44 INFO - Installing collected packages: psutil 06:57:44 INFO - Running setup.py install for psutil 06:57:44 INFO - building 'psutil._psutil_linux' extension 06:57:44 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 06:57:44 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 06:57:44 INFO - building 'psutil._psutil_posix' extension 06:57:44 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 06:57:45 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 06:57:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:45 INFO - Successfully installed psutil 06:57:45 INFO - Cleaning up... 06:57:45 INFO - Return code: 0 06:57:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:57: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')]} 06:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:45 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 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:45 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 06:57:45 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 06:57:45 INFO - Using env: {'DISPLAY': ':0', 06:57:45 INFO - 'HOME': '/home/cltbld', 06:57:45 INFO - 'LANG': 'en_US.UTF-8', 06:57:45 INFO - 'LANGUAGE': 'en_US:en', 06:57:45 INFO - 'LOGNAME': 'cltbld', 06:57:45 INFO - 'MAIL': '/var/mail/cltbld', 06:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:45 INFO - 'MOZ_NO_REMOTE': '1', 06:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:45 INFO - 'NO_EM_RESTART': '1', 06:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:45 INFO - 'PWD': '/builds/slave/test', 06:57:45 INFO - 'SHELL': '/bin/bash', 06:57:45 INFO - 'SHLVL': '1', 06:57:45 INFO - 'TERM': 'linux', 06:57:45 INFO - 'TMOUT': '86400', 06:57:45 INFO - 'USER': 'cltbld', 06:57:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:45 INFO - '_': '/tools/buildbot/bin/python'} 06:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:57:45 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 06:57:45 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 06:57:45 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 06:57:45 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 06:57:45 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 06:57:45 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 06:57:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:57:47 INFO - Installing collected packages: mozsystemmonitor 06:57:47 INFO - Running setup.py install for mozsystemmonitor 06:57:47 INFO - Successfully installed mozsystemmonitor 06:57:47 INFO - Cleaning up... 06:57:47 INFO - Return code: 0 06:57:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:47 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 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:47 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 06:57:47 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 06:57:47 INFO - Using env: {'DISPLAY': ':0', 06:57:47 INFO - 'HOME': '/home/cltbld', 06:57:47 INFO - 'LANG': 'en_US.UTF-8', 06:57:47 INFO - 'LANGUAGE': 'en_US:en', 06:57:47 INFO - 'LOGNAME': 'cltbld', 06:57:47 INFO - 'MAIL': '/var/mail/cltbld', 06:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:47 INFO - 'MOZ_NO_REMOTE': '1', 06:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:47 INFO - 'NO_EM_RESTART': '1', 06:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:47 INFO - 'PWD': '/builds/slave/test', 06:57:47 INFO - 'SHELL': '/bin/bash', 06:57:47 INFO - 'SHLVL': '1', 06:57:47 INFO - 'TERM': 'linux', 06:57:47 INFO - 'TMOUT': '86400', 06:57:47 INFO - 'USER': 'cltbld', 06:57:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:47 INFO - '_': '/tools/buildbot/bin/python'} 06:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:47 INFO - Downloading/unpacking blobuploader==1.2.4 06:57:47 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 06:57:47 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 06:57:47 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 06:57:47 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 06:57:47 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 06:57:47 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 06:57:49 INFO - Downloading blobuploader-1.2.4.tar.gz 06:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:57:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:57:49 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 06:57:49 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 06:57:49 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 06:57:49 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 06:57:49 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 06:57:49 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 06:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:57:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:50 INFO - Downloading docopt-0.6.1.tar.gz 06:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:57:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:57:50 INFO - Running setup.py install for blobuploader 06:57:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:57:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:57:50 INFO - Running setup.py install for requests 06:57:51 INFO - Running setup.py install for docopt 06:57:51 INFO - Successfully installed blobuploader requests docopt 06:57:51 INFO - Cleaning up... 06:57:51 INFO - Return code: 0 06:57:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57:51 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')]} 06:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:51 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')]} 06:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:51 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 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:51 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 06:57:51 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 06:57:51 INFO - Using env: {'DISPLAY': ':0', 06:57:51 INFO - 'HOME': '/home/cltbld', 06:57:51 INFO - 'LANG': 'en_US.UTF-8', 06:57:51 INFO - 'LANGUAGE': 'en_US:en', 06:57:51 INFO - 'LOGNAME': 'cltbld', 06:57:51 INFO - 'MAIL': '/var/mail/cltbld', 06:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:51 INFO - 'MOZ_NO_REMOTE': '1', 06:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:51 INFO - 'NO_EM_RESTART': '1', 06:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:51 INFO - 'PWD': '/builds/slave/test', 06:57:51 INFO - 'SHELL': '/bin/bash', 06:57:51 INFO - 'SHLVL': '1', 06:57:51 INFO - 'TERM': 'linux', 06:57:51 INFO - 'TMOUT': '86400', 06:57:51 INFO - 'USER': 'cltbld', 06:57:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:51 INFO - '_': '/tools/buildbot/bin/python'} 06:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:51 INFO - Running setup.py (path:/tmp/pip-PenJaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:51 INFO - Running setup.py (path:/tmp/pip-StVzhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:51 INFO - Running setup.py (path:/tmp/pip-XRjXiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:51 INFO - Running setup.py (path:/tmp/pip-Mlt1og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:51 INFO - Running setup.py (path:/tmp/pip-4BMa0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:51 INFO - Running setup.py (path:/tmp/pip-dXoVXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:51 INFO - Running setup.py (path:/tmp/pip-D8EtaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:51 INFO - Running setup.py (path:/tmp/pip-7tGlE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:51 INFO - Running setup.py (path:/tmp/pip-Z8HPNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:52 INFO - Running setup.py (path:/tmp/pip-pgHyM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:52 INFO - Running setup.py (path:/tmp/pip-V1OQ22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:52 INFO - Running setup.py (path:/tmp/pip-A390lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:52 INFO - Running setup.py (path:/tmp/pip-8SwcjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:52 INFO - Running setup.py (path:/tmp/pip-ZFqvsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:52 INFO - Running setup.py (path:/tmp/pip-Ppc0i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:52 INFO - Running setup.py (path:/tmp/pip-kG3qbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:52 INFO - Running setup.py (path:/tmp/pip-EI6tMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:57:52 INFO - Running setup.py install for manifestparser 06:57:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:57:52 INFO - Running setup.py install for mozcrash 06:57:52 INFO - Running setup.py install for mozdebug 06:57:52 INFO - Running setup.py install for mozdevice 06:57:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:57:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Running setup.py install for mozfile 06:57:53 INFO - Running setup.py install for mozhttpd 06:57:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Running setup.py install for mozinfo 06:57:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Running setup.py install for mozInstall 06:57:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Running setup.py install for mozleak 06:57:53 INFO - Running setup.py install for mozlog 06:57:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Running setup.py install for moznetwork 06:57:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Running setup.py install for mozprocess 06:57:53 INFO - Running setup.py install for mozprofile 06:57:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:57:53 INFO - Running setup.py install for mozrunner 06:57:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:57:54 INFO - Running setup.py install for mozscreenshot 06:57:54 INFO - Running setup.py install for moztest 06:57:54 INFO - Running setup.py install for mozversion 06:57:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:57:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:57:54 INFO - Cleaning up... 06:57:54 INFO - Return code: 0 06:57:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57: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')]} 06:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:54 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 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:54 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 06:57:54 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 06:57:54 INFO - Using env: {'DISPLAY': ':0', 06:57:54 INFO - 'HOME': '/home/cltbld', 06:57:54 INFO - 'LANG': 'en_US.UTF-8', 06:57:54 INFO - 'LANGUAGE': 'en_US:en', 06:57:54 INFO - 'LOGNAME': 'cltbld', 06:57:54 INFO - 'MAIL': '/var/mail/cltbld', 06:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:54 INFO - 'MOZ_NO_REMOTE': '1', 06:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:54 INFO - 'NO_EM_RESTART': '1', 06:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:54 INFO - 'PWD': '/builds/slave/test', 06:57:54 INFO - 'SHELL': '/bin/bash', 06:57:54 INFO - 'SHLVL': '1', 06:57:54 INFO - 'TERM': 'linux', 06:57:54 INFO - 'TMOUT': '86400', 06:57:54 INFO - 'USER': 'cltbld', 06:57:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:54 INFO - '_': '/tools/buildbot/bin/python'} 06:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:57:54 INFO - Running setup.py (path:/tmp/pip-prZqP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:57:54 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)) 06:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:57:54 INFO - Running setup.py (path:/tmp/pip-WnLNQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:57:54 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)) 06:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:57:54 INFO - Running setup.py (path:/tmp/pip-6zoA6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:57:54 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)) 06:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:57:54 INFO - Running setup.py (path:/tmp/pip-Bi0gf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:57:54 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)) 06:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:57:54 INFO - Running setup.py (path:/tmp/pip-2zZbLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:57:54 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)) 06:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:57:54 INFO - Running setup.py (path:/tmp/pip-podSRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:57:55 INFO - Running setup.py (path:/tmp/pip-rc6U0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:57:55 INFO - Running setup.py (path:/tmp/pip-qNuPl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:57:55 INFO - Running setup.py (path:/tmp/pip-EzDtZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:57:55 INFO - Running setup.py (path:/tmp/pip-aIM4Ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:57:55 INFO - Running setup.py (path:/tmp/pip-w2XWC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:57:55 INFO - Running setup.py (path:/tmp/pip-WSJpic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:57:55 INFO - Running setup.py (path:/tmp/pip-v1coie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:57:55 INFO - Running setup.py (path:/tmp/pip-eygm0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:55 INFO - Running setup.py (path:/tmp/pip-snfx1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:57:55 INFO - Running setup.py (path:/tmp/pip-oPi4O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:57:55 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)) 06:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:57:55 INFO - Running setup.py (path:/tmp/pip-pgARwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:57:55 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)) 06:57:55 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)) 06:57:55 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)) 06:57:55 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)) 06:57:55 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)) 06:57:55 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)) 06:57:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:57 INFO - Downloading blessings-1.6.tar.gz 06:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:57:57 INFO - Installing collected packages: blessings 06:57:57 INFO - Running setup.py install for blessings 06:57:57 INFO - Successfully installed blessings 06:57:57 INFO - Cleaning up... 06:57:57 INFO - Return code: 0 06:57:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:57:58 INFO - Reading from file tmpfile_stdout 06:57:58 INFO - Current package versions: 06:57:58 INFO - argparse == 1.2.1 06:57:58 INFO - blessings == 1.6 06:57:58 INFO - blobuploader == 1.2.4 06:57:58 INFO - docopt == 0.6.1 06:57:58 INFO - manifestparser == 1.1 06:57:58 INFO - mozInstall == 1.12 06:57:58 INFO - mozcrash == 0.17 06:57:58 INFO - mozdebug == 0.1 06:57:58 INFO - mozdevice == 0.48 06:57:58 INFO - mozfile == 1.2 06:57:58 INFO - mozhttpd == 0.7 06:57:58 INFO - mozinfo == 0.9 06:57:58 INFO - mozleak == 0.1 06:57:58 INFO - mozlog == 3.1 06:57:58 INFO - moznetwork == 0.27 06:57:58 INFO - mozprocess == 0.22 06:57:58 INFO - mozprofile == 0.28 06:57:58 INFO - mozrunner == 6.11 06:57:58 INFO - mozscreenshot == 0.1 06:57:58 INFO - mozsystemmonitor == 0.0 06:57:58 INFO - moztest == 0.7 06:57:58 INFO - mozversion == 1.4 06:57:58 INFO - psutil == 3.1.1 06:57:58 INFO - requests == 1.2.3 06:57:58 INFO - wsgiref == 0.1.2 06:57:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:57: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')]} 06:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:58 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 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:58 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 06:57:58 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 06:57:58 INFO - Using env: {'DISPLAY': ':0', 06:57:58 INFO - 'HOME': '/home/cltbld', 06:57:58 INFO - 'LANG': 'en_US.UTF-8', 06:57:58 INFO - 'LANGUAGE': 'en_US:en', 06:57:58 INFO - 'LOGNAME': 'cltbld', 06:57:58 INFO - 'MAIL': '/var/mail/cltbld', 06:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:58 INFO - 'MOZ_NO_REMOTE': '1', 06:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:58 INFO - 'NO_EM_RESTART': '1', 06:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:58 INFO - 'PWD': '/builds/slave/test', 06:57:58 INFO - 'SHELL': '/bin/bash', 06:57:58 INFO - 'SHLVL': '1', 06:57:58 INFO - 'TERM': 'linux', 06:57:58 INFO - 'TMOUT': '86400', 06:57:58 INFO - 'USER': 'cltbld', 06:57:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:58 INFO - '_': '/tools/buildbot/bin/python'} 06:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 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)) 06:57:58 INFO - Cleaning up... 06:57:58 INFO - Return code: 0 06:57:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:57: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')]} 06:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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')]} 06:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:57:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:57:58 INFO - Using env: {'DISPLAY': ':0', 06:57:58 INFO - 'HOME': '/home/cltbld', 06:57:58 INFO - 'LANG': 'en_US.UTF-8', 06:57:58 INFO - 'LANGUAGE': 'en_US:en', 06:57:58 INFO - 'LOGNAME': 'cltbld', 06:57:58 INFO - 'MAIL': '/var/mail/cltbld', 06:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:58 INFO - 'MOZ_NO_REMOTE': '1', 06:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:58 INFO - 'NO_EM_RESTART': '1', 06:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:58 INFO - 'PWD': '/builds/slave/test', 06:57:58 INFO - 'SHELL': '/bin/bash', 06:57:58 INFO - 'SHLVL': '1', 06:57:58 INFO - 'TERM': 'linux', 06:57:58 INFO - 'TMOUT': '86400', 06:57:58 INFO - 'USER': 'cltbld', 06:57:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:58 INFO - '_': '/tools/buildbot/bin/python'} 06:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:58 INFO - Downloading/unpacking jsonschema 06:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:00 INFO - Downloading/unpacking functools32 (from jsonschema) 06:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:00 INFO - warning: no files found matching '*.txt' 06:58:00 INFO - no previously-included directories found matching 'build' 06:58:00 INFO - no previously-included directories found matching 'dist' 06:58:00 INFO - no previously-included directories found matching '.git*' 06:58:00 INFO - Installing collected packages: jsonschema, functools32 06:58:00 INFO - Running setup.py install for functools32 06:58:00 INFO - warning: no files found matching '*.txt' 06:58:00 INFO - no previously-included directories found matching 'build' 06:58:00 INFO - no previously-included directories found matching 'dist' 06:58:00 INFO - no previously-included directories found matching '.git*' 06:58:00 INFO - Successfully installed jsonschema functools32 06:58:00 INFO - Cleaning up... 06:58:01 INFO - Return code: 0 06:58:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e9ac15f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f515a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', '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 06:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:58:01 INFO - Using env: {'DISPLAY': ':0', 06:58:01 INFO - 'HOME': '/home/cltbld', 06:58:01 INFO - 'LANG': 'en_US.UTF-8', 06:58:01 INFO - 'LANGUAGE': 'en_US:en', 06:58:01 INFO - 'LOGNAME': 'cltbld', 06:58:01 INFO - 'MAIL': '/var/mail/cltbld', 06:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:01 INFO - 'MOZ_NO_REMOTE': '1', 06:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:01 INFO - 'NO_EM_RESTART': '1', 06:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:01 INFO - 'PWD': '/builds/slave/test', 06:58:01 INFO - 'SHELL': '/bin/bash', 06:58:01 INFO - 'SHLVL': '1', 06:58:01 INFO - 'TERM': 'linux', 06:58:01 INFO - 'TMOUT': '86400', 06:58:01 INFO - 'USER': 'cltbld', 06:58:01 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:01 INFO - '_': '/tools/buildbot/bin/python'} 06:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:01 INFO - Downloading/unpacking flake8 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:58:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:58:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:58:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:03 INFO - no previously-included directories found matching 'docs/_build' 06:58:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:58:04 INFO - Running setup.py install for pep8 06:58:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:04 INFO - no previously-included directories found matching 'docs/_build' 06:58:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:58:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:58:04 INFO - Cleaning up... 06:58:04 INFO - Return code: 0 06:58:04 INFO - Running post-action listener: _resource_record_post_action 06:58:04 INFO - Running post-action listener: _start_resource_monitoring 06:58:04 INFO - Starting resource monitoring. 06:58:04 INFO - ##### 06:58:04 INFO - ##### Running install step. 06:58:04 INFO - ##### 06:58:04 INFO - Running pre-action listener: _resource_record_pre_action 06:58:04 INFO - Running main action method: install 06:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:04 INFO - Reading from file tmpfile_stdout 06:58:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:04 INFO - Reading from file tmpfile_stdout 06:58:04 INFO - Output received: 06:58:04 INFO - Usage: mozinstall [options] installer 06:58:04 INFO - Options: 06:58:04 INFO - -h, --help show this help message and exit 06:58:04 INFO - -d DEST, --destination=DEST 06:58:04 INFO - Directory to install application into. [default: 06:58:04 INFO - "/builds/slave/test"] 06:58:04 INFO - --app=APP Application being installed. [default: firefox] 06:58:04 INFO - mkdir: /builds/slave/test/build/application 06:58:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:58:20 INFO - Reading from file tmpfile_stdout 06:58:20 INFO - Output received: 06:58:20 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:20 INFO - Running post-action listener: _resource_record_post_action 06:58:20 INFO - ##### 06:58:20 INFO - ##### Running run-tests step. 06:58:20 INFO - ##### 06:58:20 INFO - Running pre-action listener: _resource_record_pre_action 06:58:20 INFO - Running main action method: run_tests 06:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:20 INFO - Python 2.7.3 06:58:20 INFO - Return code: 0 06:58:20 INFO - grabbing minidump binary from tooltool 06:58:20 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')]} 06:58:20 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 0x1fe0410>, '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 0x1fe1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fe17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:20 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 06:58:20 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 06:58:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:20 INFO - Return code: 0 06:58:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:58:21 INFO - Return code: 0 06:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 06:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 06:58:21 INFO - Using env: {'DISPLAY': ':0', 06:58:21 INFO - 'HOME': '/home/cltbld', 06:58:21 INFO - 'LANG': 'en_US.UTF-8', 06:58:21 INFO - 'LANGUAGE': 'en_US:en', 06:58:21 INFO - 'LOGNAME': 'cltbld', 06:58:21 INFO - 'MAIL': '/var/mail/cltbld', 06:58:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:21 INFO - 'MOZ_NO_REMOTE': '1', 06:58:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:21 INFO - 'NO_EM_RESTART': '1', 06:58:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:21 INFO - 'PWD': '/builds/slave/test', 06:58:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:21 INFO - 'SHELL': '/bin/bash', 06:58:21 INFO - 'SHLVL': '1', 06:58:21 INFO - 'TERM': 'linux', 06:58:21 INFO - 'TMOUT': '86400', 06:58:21 INFO - 'USER': 'cltbld', 06:58:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959', 06:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:21 INFO - '_': '/tools/buildbot/bin/python'} 06:58:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 06:58:21 INFO - mozversion application_buildid: 20160426061007 06:58:21 INFO - mozversion application_changeset: e51ba816be5f43ce0cfd0d204247473122c9951f 06:58:21 INFO - mozversion application_display_name: Nightly 06:58:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:21 INFO - mozversion application_name: Firefox 06:58:21 INFO - mozversion application_remotingname: firefox 06:58:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:58:21 INFO - mozversion application_vendor: Mozilla 06:58:21 INFO - mozversion application_version: 49.0a1 06:58:21 INFO - mozversion platform_buildid: 20160426061007 06:58:21 INFO - mozversion platform_changeset: e51ba816be5f43ce0cfd0d204247473122c9951f 06:58:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:58:21 INFO - mozversion platform_version: 49.0a1 06:58:21 INFO - using testdate: 1461679101 06:58:21 INFO - actual date: 1461679101 06:58:21 INFO - starting webserver on 'localhost:53262' 06:58:21 INFO - SUITE-START | Running 2 tests 06:58:21 INFO - TEST-START | dromaeo_css 06:58:21 INFO - operating with platform_type : linux_ 06:58:21 INFO - Initialising browser for dromaeo_css test... 06:58:21 INFO - TEST-INFO | started process 29320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH9Mjjn/profile http://localhost:53262/getInfo.html) 06:58:25 INFO - PROCESS | 29320 | __metrics Screen width/height:1600/1200 06:58:25 INFO - PROCESS | 29320 | colorDepth:24 06:58:25 INFO - PROCESS | 29320 | Browser inner width/height: 1024/697 06:58:25 INFO - PROCESS | 29320 | __metrics 06:58:26 ERROR - PROCESS | 29320 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:58:27 INFO - TEST-INFO | 29320: exit 0 06:58:27 INFO - Browser initialized. 06:58:27 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:27 INFO - TEST-INFO | started process 29400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH9Mjjn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:39 INFO - PROCESS | 29400 | RSS: Main: 155787264 06:58:39 INFO - PROCESS | 29400 | 06:59:31 INFO - PROCESS | 29400 | 1461679171028 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] 07:01:42 INFO - PROCESS | 29400 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53262/tests/dromaeo/cssquery-ext.html) 07:01:43 INFO - PROCESS | 29400 | RSS: Main: 256860160 07:01:43 INFO - PROCESS | 29400 | 07:04:45 INFO - PROCESS | 29400 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-ext.html (next: http://localhost:53262/tests/dromaeo/cssquery-jquery.html) 07:04:46 INFO - PROCESS | 29400 | RSS: Main: 227639296 07:04:46 INFO - PROCESS | 29400 | 07:07:48 INFO - PROCESS | 29400 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53262/tests/dromaeo/cssquery-mootools.html) 07:07:49 INFO - PROCESS | 29400 | RSS: Main: 237338624 07:07:49 INFO - PROCESS | 29400 | 07:10:51 INFO - PROCESS | 29400 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53262/tests/dromaeo/cssquery-prototype.html) 07:10:52 INFO - PROCESS | 29400 | RSS: Main: 236720128 07:10:52 INFO - PROCESS | 29400 | 07:13:55 INFO - PROCESS | 29400 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53262/tests/dromaeo/cssquery-yui.html) 07:13:55 INFO - PROCESS | 29400 | RSS: Main: 215388160 07:13:55 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | Cycle 1(1): loaded http://localhost:53262/tests/dromaeo/cssquery-yui.html (next: http://localhost:53262/tests/dromaeo/cssquery-dojo.html) 07:16:58 INFO - PROCESS | 29400 | RSS: Main: 263278592 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | __start_tp_report 07:16:58 INFO - PROCESS | 29400 | _x_x_mozilla_page_load 07:16:58 INFO - PROCESS | 29400 | _x_x_mozilla_page_load_details 07:16:58 INFO - PROCESS | 29400 | |i|pagename|runs| 07:16:58 INFO - PROCESS | 29400 | |0;dojo.html;2575.407656239065;2622.4492856500124;2635;2642.616820561019;2669.59956006599;4468.151051300259;4532.252178390566;4547.7271363718155;4548.317752337151;4585.931211031829;4521.547845215485;4554.544545545444;4598.471175814782;4688.6249100072;4698.08387364464;4144.254034273829;4146.440230568873;4185.351270553069;4209.621134097931;4344.4786625604975;4283.079137985333;4287.699861009731;4302.053548219386;4333.631641310492;4334.978325108385;4142.482189726285;4192.601702838226;4230.280852255124;4232.534421213664;4243.809028593705;4208.263553878059;4232.703710740249;4236.703430759848;4240.554741752102;4277.721948073366;4218.831246750157;4221.472315960505;4239.0885959518855;4252.277112890816;4271.017665936821;4362.847300344504;4427.889302767424;4442.3336499525;4464.062546865162;4513.909721805546;4857.0043141155975;4875.293082503053;4879.902401951941;4903.092927808331;4924.901501969976;4883.072216278895;4907.533784290486;4912.459629440758;4916.754162291907;4948.703077815343;4472.396226509444;4593.954060459353;4596.471405788344;4626.236670949323;4665.043666048452;4978.1288274552535;5003;5003.574696150795;5004.624653150955;5042.142835717937;4805.639577031737;4805.783739731721;4807.95192048075;4812.831550895702;4856.2958371036;4791.688540244873;4857.611391088704;4931.087748766418;4937.456879743226;4938.58022068121;4833.975830120827;4842.903141937212;4848.830290939871;4884.92672609904;4893.486183950634;4831.251156070814;4835.395575553056;4835.58897493717;4847.345608342828;4884.682495637772;4160.750354978651;4206.284931561642;4228.640565551963;4230.963413963537;4264.530901600821;3684.8526058957877;3709.1283548366114;3735.4210097434943;3757.4551690004796;3794.3359912015285;4274.2092712848225;4281.614654681093;4286.421333119989;4292.291771857608;4345.174416860849;4771.594414474739;4907.55831975124;4920.335754673145;4933.260010998379;4979.551840334315;4269.444972153662;4272.124214536013;4298.957010429918;4302.89242768927;4312.482502099768;4455.754933478625;4456.04195098049;4460.219461594208;4460.933086003713;4505.819767209275;4530.161920044802;4648.442186937589;4650.9767451162525;4685.367475390847;4727.669063165546;4898.21628539432;4899.951000489949;4909.459959404534;4932.383452068491;4940;4644.3265726470145;4647.721136731807;4651.116287905287;4655.83704570352;4707.529247075265;4567.520410356865;4776.5701086902345;4807.375041244616;4838.129136755418;4857.271409288635;4912.828051018198;4913.115639184838;4929.06347793918;4938.234573641092;4954.727489988085;4765.9046819064115;4767.976160119178;4773;4775.785089670903;4819.108464933998;4653.418322709661;4720.244760838249;4756.429228492603;4763.499832517536;4820.590249828663;4635.7218566886095;4642.280446530793;4649.651276154234;4675.181843177363;4679.157751604744;4723.173444647105;4735.076660051394;4739.170645137018;4784.593309568726;4793.0413917216;4562.908741825211;4627.490975992706;4632.5830675239395;4652.185867473247;4689.109069276827 07:16:58 INFO - PROCESS | 29400 | |1;ext.html;566.3289002532;594.0050415553947;596.3559355895632;599.086393250293;611.0650704422234;22424;33489.162770930736;33754.8312258439;33918.49122263165;33975.15062123448;33460.49809252863;34176.316473670515;34238.828805855934;34240.48639270413;34264;6855;7427.665755041036;7694.038245219348;9325.487098209629;9600.375975561601;9408.576614052385;9620.518974051269;9628.566714497865;9634.951825240863;9638.566264518113;9539.523023848815;9709.61161553537;9711.465869377182;9718.465484398355;9718.805623887518;6866.382025617693;9304.534773261345;9581.185599224074;9585.616575336979;9587.041295870427;9461.290403219786;9621.374610650286;9622.182114520274;9623.807523849553;9629.662961796303;27723.72276277252;28148.859255703795;28237.576436353473;28239.57640635392;28294.858525707445;2985.462616728988;3102.4105419970133;3166.746660267173;3314.767966242364;3447.9310413791836;26691.19926402211;26693.466130677472;26879.193624191306;26979.460410791675;27315.453690926268;3459.809710465923;3491.5460990071383;3515.2969406118877;3532.452469867175;3582.0865679251883;147857;150470.9999999989;150570;150709;151028;42541.36187957183;43112.56887431148;43197;43197.56802431998;43208.56791432108;47676.046479070916;48278.27582586264;48308.75845620749;48312.5168748308;48378.27432588514;11362.829557556643;12154.453049612788;12228.75542489163;12238.143329966995;12271.018318534496;10824.296420732628;10966.396848173426;10990.340579565252;10997.505112269968;11007.944960275147;16509.422170223985;16517;16521.752173717403;16522.339106435847;16540.172991350384;6452.064450654629;6581.308962558958;6707.5975441473665;6712.865742685119;6715.1941766988275;772.729544659376;831.7629475599425;838.375410319316;887.430887580451;946.4037656276502;25642.871785640953;26074.34814129624;26079.739202607732;26197.607035894478;26206.475870482485;891.6344298837575;893.8391089603933;911.9908800912038;961.3847137831793;979.1334668818005;13402.396892139877;13794.310284485735;13854.30728463593;14119.717605648035;14260.500882469063;274325;277658;280441;280618;280643;45056;45936;46140;46141.76929115333;46162;1018.8930162332848;1033.8914413986574;1169.2458364355114;1252.8496580410408;1259.6472987563498;23836.918335290535;27307.453850923266;27358.726412736414;27813;27882.16353509398;38075;38918.80540597279;38969.80515097406;39053;39060.41409378805;194592;195747;197781.1996920284;197785;204223;18075.186616602547;22146.77853221447;22347.217847375265;22607.20874769441;22669.319920402413;34959.28049713256;35036.649633504356;35041.12397190091;35886;36019.27961440704;30496;30867;30895.382092358475;31065.8446707765;31432.52851207188;25031.874840625682;25836.095736649128;26674.19977400681;26724.599131012663;27061.10572259923;32674;32999.34001320008;33180;33517.16207094842;33700.662993369755;29421.558676620298;29788.255293617833;30064.398712026075;30432.84783576068;30455.84772076214;20825.89587052055;23628.763712363343;23758;24136.275911722678;24397.26808195757 07:16:58 INFO - PROCESS | 29400 | |2;jquery.html;377.08556749881546;378.98105094745256;380.7696343712054;385.9324618191816;387.4807757604809;15288.923555382222;15376.308066137022;16329.101899395528;16334.34662613494;16363.672726545477;12921.353932303395;14788.334524946376;15716.292766825492;16122;16146.273417696202;4330.523642399334;4530.569595888385;4566.132434837386;4568.269076947689;4570;3419.897403077899;4515.683902126852;5031.295618613397;5315.521603055724;5342.759575819078;5276.92084618731;5317.9202311965155;5328.973355133219;5343.706096164709;5346.599005074616;5069.670471419365;5298.417174110845;5325.547328477045;5338.3060202173665;5339.279197308352;3337.0823023668686;5028.396592408898;5148.485151484859;5268.157094864803;5281.867953301198;11714.180007399485;11847.289162650268;11901.880981190165;12307.75384492305;17213.7417938731;1846.796852346241;1898.506388339042;2092.801183887528;2465.1988103866315;2504.3864253258066;8718.694845680371;8768.210861022539;8817;9179.541022948826;9270.860937085949;1725.9741103883453;1743.2329774899003;1772.3619496981205;1808.6653969015642;1814.7368631548484;59084.70457647727;60163;60670.089948650806;61069.389306106816;61371;9739.464329461805;9934.155596774355;9969.700908972742;9971.451570163566;10056.74858128538;13781.862181378057;13893.513727019506;13907.513237036655;13932.303384830719;13940.930295348458;7189.532680375759;7314.890276645855;7331.596762178025;7385.778426647209;7576.734814281584;6934.879304313079;7033.261507541737;7039.894401583981;7044.964775176091;7118.679659415235;4353.956460435418;4360.084382279757;4432.246518091933;4488.461384633865;4516.36770852081;1568.8431156884449;1668.3910372713872;1764.1708397053364;1779.7953235377838;1915.5785727140008;795.7732046366758;897.7441429192648;923.7505873414275;936.7939053408239;942.990570094304;14828.184449855145;15080.321385537678;15091.471798487;16723.163841807862;16822.495325140266;759.2217976574055;798.8082860113531;822.4777266435856;828.1180542721982;862.0775769926245;8479.06730259671;9101.180893719596;9233.215176710055;9253.953730231306;9476.241900647932;381311;386865;390855;393617;396073;66739;67927;68618.3138168622;68926.65536672284;69662.65168674226;976.3897564022486;978.7406337320616;989.8861630912537;991.0584944302941;992.7220378294089;14270.785938210727;14338.856611433752;14561.781573276621;14600.488982885548;15059.548213553611;32092.83953580217;32715.509267361485;32814.67185328212;33592.49611255784;33717.83141084279;45106.323405148294;46239.537604623525;46433;46549.069018618764;46731.76634116808;7339.449541284318;7382.224866388952;7394.704211831681;7407.407407407502;7501.2123727007875;9493.85759213626;11424.657260282205;11556.653300401002;11616.12879034059;11763.294202347886;10132.645357412455;10288.691339259834;10358.689239322832;10364.792704146026;10479.63321283782;8885.600147993486;9388;9479.620815167593;10125.898741012496;10367.844482332923;10331.22515811302;10412.32319899204;10425.895741042492;10605.522751476356;10768.51541680642;7529.774106776806;7576.431767617561;7685.846283074419;7696.114946781192;7817.022872140982;9760.511974401394;10074.848877266993;10437.16502679799;10492.42613607965;10500.369977801356 07:16:58 INFO - PROCESS | 29400 | |3;mootools.html;1123.7696272264186;1376.4631793600495;1435.2895316818174;1582.825889152193;1766.258171567942;6275.466585340246;7603.543787372754;7815.413843961712;7828.960855195716;7832.686692532292;7652.3878089752825;7657;7710.460267781257;7721.30508254257;7741.187175346592;1848.380792434536;2194.2758889566485;2213.7786221377814;2241.607718649238;2244.876531790751;2244.7867452591977;2272.136588096521;2274.351809734226;2276.237460450751;2278.4873403484166;2159.470929622245;2172.2397160993605;2237.4182712494785;2242.990654205606;2243.9439014024615;1860.9999999999932;2125.2455378340774;2147.7100591420194;2194.5172062146303;2203.834712396577;2195.560887822442;2200.3179014505554;2227.7994980451676;2228.275810361623;2230.609643312414;7787.805304867367;7796.844063118762;7850.9214907850765;7856.567888766115;7873.212678732139;4452.821887124511;4657.953420465819;4663.137319595886;4664.813407463697;4665.996810685685;2863.2984918694847;2879.752365261244;2918.066218809982;2950.734433900959;2984.7015298470196;866.9869951950726;869.826034793044;877.2762470961419;886.9157430044136;894.8881389826272;10937.343759374384;10959.452027398598;10975.945120274348;10984;10999.175061870392;4167.6874234432535;4281;4361.1495758327455;4363.890902727394;4370.847020354272;9259.444433334022;9319.068093190763;9322.30082743797;9326.300527460331;9341.57962891658;4710.528947105262;4722.740249286322;4735.621150307967;4739.691920025188;4740.241561350167;3498.5626796650417;4011.799410029545;4144.668426525871;4154.127633197002;4156.854510092132;3377.7973321600784;3460.567429071366;3481.2515309208643;3518.648135186461;3530.2057037166946;1145.2441388683428;1156.5200441816721;1162.041315914374;1167.054685704582;1188.4295538141569;660.5211221864206;670.6210990790188;687.7214728035153;769.0156599552581;771.0362047440699;5039.697618142924;5240.423553409122;5267.367915850046;5268;5310.362756469249;805.5529181304315;818.43119032272;830.4270053662954;867.1805144138729;879.2570278115111;3337.5828021497314;3383.2556837495713;3438.707709844691;3448.9482657760154;3564.625714299961;8862.556872156496;9073.682421115229;9239.076092390842;9250.444973301623;9303.25573954082;9218.631254749735;9511.90488095124;9527.761805954906;9597.47213903242;9620.75948101303;7410.444216683771;7414.184439711627;7514.586697731568;7542.434317426215;7600.239976002466;5211.635185537128;5220.347456567929;5235.554977826775;5298.549623282064;5320.760565774627;8959.552022398984;9023.323250756088;9308.162265396148;9324.906750932403;9340.206082483064;9355.4386736796;9357.812843743222;9468.384555003902;9473.431594104375;9484.525773711424;5394.973025134849;6154.630722156685;6243.719032643633;6305.243370795534;6417.550771445954;7305.3425191732995;7325.6337183141695;7389.852202956018;7390.704371825067;7404.740834070997;6082.90875636857;6727.226368967631;6740.528163028541;6812;6871.9312806873295;6594.538382313384;6649.202095748541;6735.360140786617;6744.460443164633;6782;6450.064740612679;6484.962406015015;6518.934810651833;6523.217213934358;6530.771423000362;4491.079328737535;4514.796834142406;4649.325847752125;4677.368555244999;4717.3159891816185;4643.628509719282;4645.465771436328;4685.6251499879245;4800.807967681393;4818 07:16:58 INFO - PROCESS | 29400 | |4;prototype.html;300.8134956327076;313.9058282515245;314.18625759283464;314.9244181396465;317.5411530338662;4568.451785785702;4669.533046695329;4715.339852420664;4799.496052914446;4804.423469183698;4522.954770452295;4681.414823147106;4709.340692303081;4723.055388922212;4731.90536189276;3748.369459285213;3755.230177813555;3766.6045065268163;3773.2830762155104;3778.433235014756;3551.3607550640872;3602.711783057362;3748.3815170496837;3780.5652349979828;3783.905402364949;3740.9251814963686;3745.3071181831447;3754.2116155607355;3779.055236190952;3780.6975441964714;3708.312717713434;3737.4393840923944;3751.381022131345;3753.906152346186;3756.1548651553453;3344.2809795893754;3349.330133973215;3366.259422926952;3367.5285460035616;3371.089805752433;4474.437465214297;4482.148391805546;4541.114482675879;4546.681732278742;4548.545145485458;4242.472709824461;4248.130822438148;4249.3413520904305;4262.509811371701;4279.572042795727;4912.70523768575;4948.331975183341;4971.850844474671;4974.87562810929;4975.651704380694;3546.7517273790845;3636.8363423646;3652.251288485854;3661.5972243053243;3669.6697297243377;5072.315237442935;5137.409197942247;5143.27994080829;5174.974125129388;5177.741112944375;3720.2187540616774;3722.590515043343;3723.2739615775204;3727.906802329909;3743.307488114653;3776.263628592398;3784.6404591563755;3785.5268091488565;3794.6774524165753;3798.867039653599;4061.1674606705556;4204.957950420457;4215.3044747616295;4223.429836971969;4250.341197114452;4852.975735121302;4884.511548845158;4911.968486617779;4928.6303527235605;4947.233178857283;1288.4652869059423;1325.7812460943837;1371.91082579634;1384.9099808512617;1390.4716207841159;932.7574830544107;945.5910693067418;958.075457183821;968.1818863060703;968.2350942755145;4646.163690535736;4661.9976705008585;4680.321353403738;4695.882602934886;4699.577038066591;5405.162199859028;5416.2688037114485;5440.646357986719;5444.557192344032;5450.4549545045975;4274.679399045084;4673;4675.275332323496;4682.929756053662;4684.95315046852;2958.8991815811014;2973.2864112612815;2977.76177905767;2984.253936515871;2990.386970671007;5280.419153893069;5286.60350473716;5310.522053015247;5311.9734401328515;5322.068637988414;5074.898502029939;5304.867378315573;5332.999999999923;5700.287464066992;5715.485606295453;4955.157623204064;4976.576990955737;4977.925331120036;4979.278004689228;4993.1262029144755;5187.118189907649;5240.921386179287;5246.921296180637;5260.631755777059;5266.97366513165;4802.423709154924;5091.770870310919;5092.923606145837;5100.362454693163;5108.872278193075;4915.877103072452;4921.384826896638;4950.900981980412;4951.356323678043;4953.925691114709;3650.926981460409;3690.760100593453;3701.8889433317045;3709.9258014840093;3715.9442608361437;4935.975320123376;5093.439721630543;5203.323567936295;5211.270422140828;5237.240600113038;4909.3126962224605;4970.900581988412;5040.621953353587;5046.839226977889;5048.167052436307;5009.974950125226;5055.16589762685;5058.519440653132;5060.8987820242655;5084.2881996521255;4830.2513110467935;4900.803967841246;4910.312556242057;4957.752112394438;4967.975160124176;4965.702057876539;4999.525045120708;5012;5032.723200224023;5037.790930176658;4885.291632713165;4921;4926.802927882988;4927.655064145475;4934.136526107845 07:16:58 INFO - PROCESS | 29400 | |5;yui.html;649.5031301054693;756.5044895593388;762.4129420346331;779.9610019499023;791.216695471483;12421.254724716511;12591.433385497652;12666.746665066694;12705.36473176342;12735.872641273596;11445;12016.038716902649;12033.21784084034;12035.398230088504;12079.516819327238;534.4174849414138;785.5954183595425;792.8017995501125;813.2680587471293;822.181928980665;812.0580127052621;812.3501199040774;813.9837203255931;814.9348052155814;815.0789607743242;853.3173461231021;853.5134973065324;855.0167307596251;855.2388374346837;855.5593869157389;541.6668748719549;821.2239433735123;847.6990668312752;856.3534531428794;856.618804631939;605.9697015149225;607.4836389069255;608.3217212807688;608.5344711295862;609.0225188572322;11817.940910295394;11860.466279017464;11864.88135118655;11875.465604047838;11875.762484750257;11576.305421674726;11916.523339066514;12067.215630984047;12128.211666241667;12336.5065397384;9639.951800240953;10111.595536178544;10135.7466063349;10249.128824049965;10299.073083422452;4088.8773336799945;4113.341865301538;4203.516595591515;4230.090530535949;4318;39744.40383394252;40668.389974150414;40691.7965410174;40779.38830917509;41485.96285092866;9889.50552472388;9972.700818975442;10036.498175091216;10088.142507886912;10391;17714.822851771318;17735.379261726037;17763.289468421117;17764.733528997076;17769.911150444164;6298;6382.074599183093;6551.803445896536;6743.730250790011;6959.269276725972;3733.4586484959527;3799.848006079726;3890.7081968851885;3894.182221733411;3894.2600905827803;2824.8163869348427;2883.0341835485347;2883.250354907739;2884.942301153965;2889.4076714273524;496.58535123172555;500.7871654546803;507.520393228403;517.004363158209;524.6799452334074;543.7688982182557;561.3236050559067;572.3360901354409;573.9110437882135;600.5315853634172;7596.316331530189;7605.619719014027;7630.694772209161;7824.608769561499;7843.411744119214;549.126888247688;574.4600075928614;579.3916387792885;588.7762650192899;591.5740666719955;3493.6681015303507;3780.8676696316047;3796.6583007529457;3827.2919509890758;3903.394973779069;52651.73674131605;55682.72158639262;55734.72132639311;55775.721121394134;55786.44213557894;43932;44202;44921.10157796826;45538.316925246145;45965.77017114893;41638.583614164076;43571;44947.77526112348;45085.294882307164;45673.086538269046;8010.959945200237;8133.349332053303;8360.916390836013;8387;8482.448640838325;29988.400231995674;30103.849480752455;30355.696443035285;30427.391452171276;30694;38093.4285985716;40730.1853962925;41013;41206.587934120274;41722.791386042874;10154.111626800093;10403.167746580104;10459.633912813319;10791.460426978776;10804.297720648132;11030.28303160292;11123.499442525268;11293.887061129612;11627.476763545492;11843.881561184278;10694.73263168427;10918.290311129751;11002.50488727993;11175.441227938409;11536;11021.44892755343;11268.211225214156;11534.769304614028;11686.24039437434;11878.287302761863;10666.306690065121;10778.622748203776;11026;11162.720931976766;11325.71685707864;9381.202597778993;9407.576659050223;9498.14516693501;9518.19095376873;9903.356281841658;8744.344174186834;9243.2143267823;9255.120763527455;9298.256139508689;9447.055294470498 07:16:58 INFO - PROCESS | 29400 | __end_tp_report 07:16:58 INFO - PROCESS | 29400 | __start_cc_report 07:16:58 INFO - PROCESS | 29400 | _x_x_mozilla_cycle_collect,953 07:16:58 INFO - PROCESS | 29400 | __end_cc_report 07:16:58 INFO - PROCESS | 29400 | __startTimestamp1461680218692__endTimestamp 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | ------- Summary: start ------- 07:16:58 INFO - PROCESS | 29400 | Number of tests: 6 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | [#0] dojo.html Cycles:165 Average:4534.60 Median:4649.65 stddev:448.79 (9.7%) stddev-sans-first:423.03 07:16:58 INFO - PROCESS | 29400 | Values: 2575.4 2622.4 2635.0 2642.6 2669.6 4468.2 4532.3 4547.7 4548.3 4585.9 4521.5 4554.5 4598.5 4688.6 4698.1 4144.3 4146.4 4185.4 4209.6 4344.5 4283.1 4287.7 4302.1 4333.6 4335.0 4142.5 4192.6 4230.3 4232.5 4243.8 4208.3 4232.7 4236.7 4240.6 4277.7 4218.8 4221.5 4239.1 4252.3 4271.0 4362.8 4427.9 4442.3 4464.1 4513.9 4857.0 4875.3 4879.9 4903.1 4924.9 4883.1 4907.5 4912.5 4916.8 4948.7 4472.4 4594.0 4596.5 4626.2 4665.0 4978.1 5003.0 5003.6 5004.6 5042.1 4805.6 4805.8 4808.0 4812.8 4856.3 4791.7 4857.6 4931.1 4937.5 4938.6 4834.0 4842.9 4848.8 4884.9 4893.5 4831.3 4835.4 4835.6 4847.3 4884.7 4160.8 4206.3 4228.6 4231.0 4264.5 3684.9 3709.1 3735.4 3757.5 3794.3 4274.2 4281.6 4286.4 4292.3 4345.2 4771.6 4907.6 4920.3 4933.3 4979.6 4269.4 4272.1 4299.0 4302.9 4312.5 4455.8 4456.0 4460.2 4460.9 4505.8 4530.2 4648.4 4651.0 4685.4 4727.7 4898.2 4900.0 4909.5 4932.4 4940.0 4644.3 4647.7 4651.1 4655.8 4707.5 4567.5 4776.6 4807.4 4838.1 4857.3 4912.8 4913.1 4929.1 4938.2 4954.7 4765.9 4768.0 4773.0 4775.8 4819.1 4653.4 4720.2 4756.4 4763.5 4820.6 4635.7 4642.3 4649.7 4675.2 4679.2 4723.2 4735.1 4739.2 4784.6 4793.0 4562.9 4627.5 4632.6 4652.2 4689.1 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | [#1] ext.html Cycles:180 Average:35928.62 Median:18157.05 stddev:56188.11 (309.5%) stddev-sans-first:56283.00 07:16:58 INFO - PROCESS | 29400 | Values: 566.3 594.0 596.4 599.1 611.1 22424.0 33489.2 33754.8 33918.5 33975.2 33460.5 34176.3 34238.8 34240.5 34264.0 6855.0 7427.7 7694.0 9325.5 9600.4 9408.6 9620.5 9628.6 9635.0 9638.6 9539.5 9709.6 9711.5 9718.5 9718.8 6866.4 9304.5 9581.2 9585.6 9587.0 9461.3 9621.4 9622.2 9623.8 9629.7 27723.7 28148.9 28237.6 28239.6 28294.9 2985.5 3102.4 3166.7 3314.8 3447.9 26691.2 26693.5 26879.2 26979.5 27315.5 3459.8 3491.5 3515.3 3532.5 3582.1 147857.0 150471.0 150570.0 150709.0 151028.0 42541.4 43112.6 43197.0 43197.6 43208.6 47676.0 48278.3 48308.8 48312.5 48378.3 11362.8 12154.5 12228.8 12238.1 12271.0 10824.3 10966.4 10990.3 10997.5 11007.9 16509.4 16517.0 16521.8 16522.3 16540.2 6452.1 6581.3 6707.6 6712.9 6715.2 772.7 831.8 838.4 887.4 946.4 25642.9 26074.3 26079.7 26197.6 26206.5 891.6 893.8 912.0 961.4 979.1 13402.4 13794.3 13854.3 14119.7 14260.5 274325.0 277658.0 280441.0 280618.0 280643.0 45056.0 45936.0 46140.0 46141.8 46162.0 1018.9 1033.9 1169.2 1252.8 1259.6 23836.9 27307.5 27358.7 27813.0 27882.2 38075.0 38918.8 38969.8 39053.0 39060.4 194592.0 195747.0 197781.2 197785.0 204223.0 18075.2 22146.8 22347.2 22607.2 22669.3 34959.3 35036.6 35041.1 35886.0 36019.3 30496.0 30867.0 30895.4 31065.8 31432.5 25031.9 25836.1 26674.2 26724.6 27061.1 32674.0 32999.3 33180.0 33517.2 33700.7 29421.6 29788.3 30064.4 30432.8 30455.8 20825.9 23628.8 23758.0 24136.3 24397.3 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | [#2] jquery.html Cycles:180 Average:23145.13 Median:4523.47 stddev:64011.22 (1415.1%) stddev-sans-first:64167.95 07:16:58 INFO - PROCESS | 29400 | Values: 377.1 379.0 380.8 385.9 387.5 15288.9 15376.3 16329.1 16334.3 16363.7 12921.4 14788.3 15716.3 16122.0 16146.3 4330.5 4530.6 4566.1 4568.3 4570.0 3419.9 4515.7 5031.3 5315.5 5342.8 5276.9 5317.9 5329.0 5343.7 5346.6 5069.7 5298.4 5325.5 5338.3 5339.3 3337.1 5028.4 5148.5 5268.2 5281.9 11714.2 11847.3 11901.9 12307.8 17213.7 1846.8 1898.5 2092.8 2465.2 2504.4 8718.7 8768.2 8817.0 9179.5 9270.9 1726.0 1743.2 1772.4 1808.7 1814.7 59084.7 60163.0 60670.1 61069.4 61371.0 9739.5 9934.2 9969.7 9971.5 10056.7 13781.9 13893.5 13907.5 13932.3 13940.9 7189.5 7314.9 7331.6 7385.8 7576.7 6934.9 7033.3 7039.9 7045.0 7118.7 4354.0 4360.1 4432.2 4488.5 4516.4 1568.8 1668.4 1764.2 1779.8 1915.6 795.8 897.7 923.8 936.8 943.0 14828.2 15080.3 15091.5 16723.2 16822.5 759.2 798.8 822.5 828.1 862.1 8479.1 9101.2 9233.2 9254.0 9476.2 381311.0 386865.0 390855.0 393617.0 396073.0 66739.0 67927.0 68618.3 68926.7 69662.7 976.4 978.7 989.9 991.1 992.7 14270.8 14338.9 14561.8 14600.5 15059.5 32092.8 32715.5 32814.7 33592.5 33717.8 45106.3 46239.5 46433.0 46549.1 46731.8 7339.4 7382.2 7394.7 7407.4 7501.2 9493.9 11424.7 11556.7 11616.1 11763.3 10132.6 10288.7 10358.7 10364.8 10479.6 8885.6 9388.0 9479.6 10125.9 10367.8 10331.2 10412.3 10425.9 10605.5 10768.5 7529.8 7576.4 7685.8 7696.1 7817.0 9760.5 10074.8 10437.2 10492.4 10500.4 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | [#3] mootools.html Cycles:180 Average:5129.28 Median:5267.68 stddev:2904.44 (55.1%) stddev-sans-first:2896.98 07:16:58 INFO - PROCESS | 29400 | Values: 1123.8 1376.5 1435.3 1582.8 1766.3 6275.5 7603.5 7815.4 7829.0 7832.7 7652.4 7657.0 7710.5 7721.3 7741.2 1848.4 2194.3 2213.8 2241.6 2244.9 2244.8 2272.1 2274.4 2276.2 2278.5 2159.5 2172.2 2237.4 2243.0 2243.9 1861.0 2125.2 2147.7 2194.5 2203.8 2195.6 2200.3 2227.8 2228.3 2230.6 7787.8 7796.8 7850.9 7856.6 7873.2 4452.8 4658.0 4663.1 4664.8 4666.0 2863.3 2879.8 2918.1 2950.7 2984.7 867.0 869.8 877.3 886.9 894.9 10937.3 10959.5 10975.9 10984.0 10999.2 4167.7 4281.0 4361.1 4363.9 4370.8 9259.4 9319.1 9322.3 9326.3 9341.6 4710.5 4722.7 4735.6 4739.7 4740.2 3498.6 4011.8 4144.7 4154.1 4156.9 3377.8 3460.6 3481.3 3518.6 3530.2 1145.2 1156.5 1162.0 1167.1 1188.4 660.5 670.6 687.7 769.0 771.0 5039.7 5240.4 5267.4 5268.0 5310.4 805.6 818.4 830.4 867.2 879.3 3337.6 3383.3 3438.7 3448.9 3564.6 8862.6 9073.7 9239.1 9250.4 9303.3 9218.6 9511.9 9527.8 9597.5 9620.8 7410.4 7414.2 7514.6 7542.4 7600.2 5211.6 5220.3 5235.6 5298.5 5320.8 8959.6 9023.3 9308.2 9324.9 9340.2 9355.4 9357.8 9468.4 9473.4 9484.5 5395.0 6154.6 6243.7 6305.2 6417.6 7305.3 7325.6 7389.9 7390.7 7404.7 6082.9 6727.2 6740.5 6812.0 6871.9 6594.5 6649.2 6735.4 6744.5 6782.0 6450.1 6485.0 6518.9 6523.2 6530.8 4491.1 4514.8 4649.3 4677.4 4717.3 4643.6 4645.5 4685.6 4800.8 4818.0 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | [#4] prototype.html Cycles:180 Average:4216.01 Median:4719.20 stddev:1204.78 (25.5%) stddev-sans-first:1171.77 07:16:58 INFO - PROCESS | 29400 | Values: 300.8 313.9 314.2 314.9 317.5 4568.5 4669.5 4715.3 4799.5 4804.4 4523.0 4681.4 4709.3 4723.1 4731.9 3748.4 3755.2 3766.6 3773.3 3778.4 3551.4 3602.7 3748.4 3780.6 3783.9 3740.9 3745.3 3754.2 3779.1 3780.7 3708.3 3737.4 3751.4 3753.9 3756.2 3344.3 3349.3 3366.3 3367.5 3371.1 4474.4 4482.1 4541.1 4546.7 4548.5 4242.5 4248.1 4249.3 4262.5 4279.6 4912.7 4948.3 4971.9 4974.9 4975.7 3546.8 3636.8 3652.3 3661.6 3669.7 5072.3 5137.4 5143.3 5175.0 5177.7 3720.2 3722.6 3723.3 3727.9 3743.3 3776.3 3784.6 3785.5 3794.7 3798.9 4061.2 4205.0 4215.3 4223.4 4250.3 4853.0 4884.5 4912.0 4928.6 4947.2 1288.5 1325.8 1371.9 1384.9 1390.5 932.8 945.6 958.1 968.2 968.2 4646.2 4662.0 4680.3 4695.9 4699.6 5405.2 5416.3 5440.6 5444.6 5450.5 4274.7 4673.0 4675.3 4682.9 4685.0 2958.9 2973.3 2977.8 2984.3 2990.4 5280.4 5286.6 5310.5 5312.0 5322.1 5074.9 5304.9 5333.0 5700.3 5715.5 4955.2 4976.6 4977.9 4979.3 4993.1 5187.1 5240.9 5246.9 5260.6 5267.0 4802.4 5091.8 5092.9 5100.4 5108.9 4915.9 4921.4 4950.9 4951.4 4953.9 3650.9 3690.8 3701.9 3709.9 3715.9 4936.0 5093.4 5203.3 5211.3 5237.2 4909.3 4970.9 5040.6 5046.8 5048.2 5010.0 5055.2 5058.5 5060.9 5084.3 4830.3 4900.8 4910.3 4957.8 4968.0 4965.7 4999.5 5012.0 5032.7 5037.8 4885.3 4921.0 4926.8 4927.7 4934.1 07:16:58 INFO - PROCESS | 29400 | 07:16:58 INFO - PROCESS | 29400 | [#5] yui.html Cycles:180 Average:12769.68 Median:4216.80 stddev:14462.96 (343.0%) stddev-sans-first:14474.89 07:16:58 INFO - PROCESS | 29400 | Values: 649.5 756.5 762.4 780.0 791.2 12421.3 12591.4 12666.7 12705.4 12735.9 11445.0 12016.0 12033.2 12035.4 12079.5 534.4 785.6 792.8 813.3 822.2 812.1 812.4 814.0 814.9 815.1 853.3 853.5 855.0 855.2 855.6 541.7 821.2 847.7 856.4 856.6 606.0 607.5 608.3 608.5 609.0 11817.9 11860.5 11864.9 11875.5 11875.8 11576.3 11916.5 12067.2 12128.2 12336.5 9640.0 10111.6 10135.7 10249.1 10299.1 4088.9 4113.3 4203.5 4230.1 4318.0 39744.4 40668.4 40691.8 40779.4 41486.0 9889.5 9972.7 10036.5 10088.1 10391.0 17714.8 17735.4 17763.3 17764.7 17769.9 6298.0 6382.1 6551.8 6743.7 6959.3 3733.5 3799.8 3890.7 3894.2 3894.3 2824.8 2883.0 2883.3 2884.9 2889.4 496.6 500.8 507.5 517.0 524.7 543.8 561.3 572.3 573.9 600.5 7596.3 7605.6 7630.7 7824.6 7843.4 549.1 574.5 579.4 588.8 591.6 3493.7 3780.9 3796.7 3827.3 3903.4 52651.7 55682.7 55734.7 55775.7 55786.4 43932.0 44202.0 44921.1 45538.3 45965.8 41638.6 43571.0 44947.8 45085.3 45673.1 8011.0 8133.3 8360.9 8387.0 8482.4 29988.4 30103.8 30355.7 30427.4 30694.0 38093.4 40730.2 41013.0 41206.6 41722.8 10154.1 10403.2 10459.6 10791.5 10804.3 11030.3 11123.5 11293.9 11627.5 11843.9 10694.7 10918.3 11002.5 11175.4 11536.0 11021.4 11268.2 11534.8 11686.2 11878.3 10666.3 10778.6 11026.0 11162.7 11325.7 9381.2 9407.6 9498.1 9518.2 9903.4 8744.3 9243.2 9255.1 9298.3 9447.1 07:16:58 INFO - PROCESS | 29400 | -------- Summary: end -------- 07:16:58 INFO - PROCESS | 29400 | 07:16:59 INFO - TEST-INFO | 29400: exit 0 07:16:59 INFO - TEST-OK | dromaeo_css | took 1117973ms 07:16:59 INFO - TEST-START | kraken 07:16:59 INFO - operating with platform_type : linux_ 07:16:59 INFO - Initialising browser for kraken test... 07:16:59 INFO - TEST-INFO | started process 29579 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7cinS/profile http://localhost:53262/getInfo.html) 07:17:03 INFO - PROCESS | 29579 | __metrics Screen width/height:1600/1200 07:17:03 INFO - PROCESS | 29579 | colorDepth:24 07:17:03 INFO - PROCESS | 29579 | Browser inner width/height: 1024/697 07:17:03 INFO - PROCESS | 29579 | __metrics 07:17:04 ERROR - PROCESS | 29579 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:17:05 INFO - TEST-INFO | 29579: exit 0 07:17:05 INFO - Browser initialized. 07:17:05 INFO - Running cycle 1/1 for kraken test... 07:17:05 INFO - TEST-INFO | started process 29666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc7cinS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:17 INFO - PROCESS | 29666 | RSS: Main: 156426240 07:17:17 INFO - PROCESS | 29666 | 07:17:20 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:21 INFO - PROCESS | 29666 | RSS: Main: 210632704 07:17:21 INFO - PROCESS | 29666 | 07:17:24 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-dft) 07:17:24 INFO - PROCESS | 29666 | RSS: Main: 197234688 07:17:24 INFO - PROCESS | 29666 | 07:17:27 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-fft) 07:17:28 INFO - PROCESS | 29666 | RSS: Main: 267931648 07:17:28 INFO - PROCESS | 29666 | 07:17:30 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53262/tests/kraken/driver.html?testName=audio-oscillator) 07:17:31 INFO - PROCESS | 29666 | RSS: Main: 176091136 07:17:31 INFO - PROCESS | 29666 | 07:17:33 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:34 INFO - PROCESS | 29666 | RSS: Main: 180408320 07:17:34 INFO - PROCESS | 29666 | 07:17:37 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53262/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:37 INFO - PROCESS | 29666 | RSS: Main: 215896064 07:17:37 INFO - PROCESS | 29666 | 07:17:41 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53262/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:41 INFO - PROCESS | 29666 | RSS: Main: 213843968 07:17:41 INFO - PROCESS | 29666 | 07:17:44 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53262/tests/kraken/driver.html?testName=json-parse-financial) 07:17:45 INFO - PROCESS | 29666 | RSS: Main: 215408640 07:17:45 INFO - PROCESS | 29666 | 07:17:47 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:47 INFO - PROCESS | 29666 | RSS: Main: 202321920 07:17:47 INFO - PROCESS | 29666 | 07:17:49 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:50 INFO - PROCESS | 29666 | RSS: Main: 206761984 07:17:50 INFO - PROCESS | 29666 | 07:17:52 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:53 INFO - PROCESS | 29666 | RSS: Main: 216686592 07:17:53 INFO - PROCESS | 29666 | 07:17:55 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:56 INFO - PROCESS | 29666 | RSS: Main: 223830016 07:17:56 INFO - PROCESS | 29666 | 07:17:59 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:00 INFO - PROCESS | 29666 | RSS: Main: 219422720 07:18:00 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:53262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53262/tests/kraken/driver.html?testName=ai-astar) 07:18:02 INFO - PROCESS | 29666 | RSS: Main: 284590080 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | __start_tp_report 07:18:02 INFO - PROCESS | 29666 | _x_x_mozilla_page_load 07:18:02 INFO - PROCESS | 29666 | _x_x_mozilla_page_load_details 07:18:02 INFO - PROCESS | 29666 | |i|pagename|runs| 07:18:02 INFO - PROCESS | 29666 | |0;ai-astar;113;113;109;114;114;115;102;114;113;116 07:18:02 INFO - PROCESS | 29666 | |1;audio-beat-detection;159;141;165;186;133;154;156;133;194;131 07:18:02 INFO - PROCESS | 29666 | |2;audio-dft;162;161;162;163;162;162;162;162;161;169 07:18:02 INFO - PROCESS | 29666 | |3;audio-fft;73;75;125;116;74;73;73;125;108;76 07:18:02 INFO - PROCESS | 29666 | |4;audio-oscillator;94;96;153;94;94;94;143;93;93;153 07:18:02 INFO - PROCESS | 29666 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;118 07:18:02 INFO - PROCESS | 29666 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;146;146 07:18:02 INFO - PROCESS | 29666 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;95;95 07:18:02 INFO - PROCESS | 29666 | |8;json-parse-financial;66;65;67;66;64;66;67;84;65;64 07:18:02 INFO - PROCESS | 29666 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;65;65 07:18:02 INFO - PROCESS | 29666 | |10;stanford-crypto-aes;78;79;79;79;79;80;85;81;88;81 07:18:02 INFO - PROCESS | 29666 | |11;stanford-crypto-ccm;137;133;150;147;137;136;139;135;170;134 07:18:02 INFO - PROCESS | 29666 | |12;stanford-crypto-pbkdf2;221;221;214;213;214;214;216;217;216;221 07:18:02 INFO - PROCESS | 29666 | |13;stanford-crypto-sha256-iterative;76;76;76;77;79;74;75;73;74;75 07:18:02 INFO - PROCESS | 29666 | __end_tp_report 07:18:02 INFO - PROCESS | 29666 | __start_cc_report 07:18:02 INFO - PROCESS | 29666 | _x_x_mozilla_cycle_collect,1907 07:18:02 INFO - PROCESS | 29666 | __end_cc_report 07:18:02 INFO - PROCESS | 29666 | __startTimestamp1461680282632__endTimestamp 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | ------- Summary: start ------- 07:18:02 INFO - PROCESS | 29666 | Number of tests: 14 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:4.06 (3.6%) stddev-sans-first:4.29 07:18:02 INFO - PROCESS | 29666 | Values: 113.0 113.0 109.0 114.0 114.0 115.0 102.0 114.0 113.0 116.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:157.50 stddev:21.96 (13.9%) stddev-sans-first:23.25 07:18:02 INFO - PROCESS | 29666 | Values: 159.0 141.0 165.0 186.0 133.0 154.0 156.0 133.0 194.0 131.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.32 (1.4%) stddev-sans-first:2.45 07:18:02 INFO - PROCESS | 29666 | Values: 162.0 161.0 162.0 163.0 162.0 162.0 162.0 162.0 161.0 169.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#3] audio-fft Cycles:10 Average:91.80 Median:73.00 stddev:23.48 (32.2%) stddev-sans-first:23.90 07:18:02 INFO - PROCESS | 29666 | Values: 73.0 75.0 125.0 116.0 74.0 73.0 73.0 125.0 108.0 76.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:94.00 stddev:27.04 (28.8%) stddev-sans-first:28.00 07:18:02 INFO - PROCESS | 29666 | Values: 94.0 96.0 153.0 94.0 94.0 94.0 143.0 93.0 93.0 153.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:18:02 INFO - PROCESS | 29666 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:18:02 INFO - PROCESS | 29666 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:18:02 INFO - PROCESS | 29666 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.00 stddev:5.93 (9.0%) stddev-sans-first:6.27 07:18:02 INFO - PROCESS | 29666 | Values: 66.0 65.0 67.0 66.0 64.0 66.0 67.0 84.0 65.0 64.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:18:02 INFO - PROCESS | 29666 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:3.18 (3.9%) stddev-sans-first:3.19 07:18:02 INFO - PROCESS | 29666 | Values: 78.0 79.0 79.0 79.0 79.0 80.0 85.0 81.0 88.0 81.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:138.00 stddev:11.36 (8.2%) stddev-sans-first:11.92 07:18:02 INFO - PROCESS | 29666 | Values: 137.0 133.0 150.0 147.0 137.0 136.0 139.0 135.0 170.0 134.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:216.70 Median:216.50 stddev:3.20 (1.5%) stddev-sans-first:2.99 07:18:02 INFO - PROCESS | 29666 | Values: 221.0 221.0 214.0 213.0 214.0 214.0 216.0 217.0 216.0 221.0 07:18:02 INFO - PROCESS | 29666 | 07:18:02 INFO - PROCESS | 29666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:76.00 stddev:1.72 (2.3%) stddev-sans-first:1.81 07:18:02 INFO - PROCESS | 29666 | Values: 76.0 76.0 76.0 77.0 79.0 74.0 75.0 73.0 74.0 75.0 07:18:02 INFO - PROCESS | 29666 | -------- Summary: end -------- 07:18:02 INFO - PROCESS | 29666 | 07:18:03 INFO - TEST-INFO | 29666: exit 0 07:18:03 INFO - TEST-OK | kraken | took 64285ms 07:18:03 INFO - SUITE-END | took 1182s 07:18:03 INFO - Completed test suite (00:19:42) 07:18:03 INFO - javascript benchmark 07:18:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.407656239065, 2622.4492856500124, 2635.0, 2642.616820561019, 2669.59956006599, 4468.151051300259, 4532.252178390566, 4547.7271363718155, 4548.317752337151, 4585.931211031829, 4521.547845215485, 4554.544545545444, 4598.471175814782, 4688.6249100072, 4698.08387364464, 4144.254034273829, 4146.440230568873, 4185.351270553069, 4209.621134097931, 4344.4786625604975, 4283.079137985333, 4287.699861009731, 4302.053548219386, 4333.631641310492, 4334.978325108385, 4142.482189726285, 4192.601702838226, 4230.280852255124, 4232.534421213664, 4243.809028593705, 4208.263553878059, 4232.703710740249, 4236.703430759848, 4240.554741752102, 4277.721948073366, 4218.831246750157, 4221.472315960505, 4239.0885959518855, 4252.277112890816, 4271.017665936821, 4362.847300344504, 4427.889302767424, 4442.3336499525, 4464.062546865162, 4513.909721805546, 4857.0043141155975, 4875.293082503053, 4879.902401951941, 4903.092927808331, 4924.901501969976, 4883.072216278895, 4907.533784290486, 4912.459629440758, 4916.754162291907, 4948.703077815343, 4472.396226509444, 4593.954060459353, 4596.471405788344, 4626.236670949323, 4665.043666048452, 4978.1288274552535, 5003.0, 5003.574696150795, 5004.624653150955, 5042.142835717937, 4805.639577031737, 4805.783739731721, 4807.95192048075, 4812.831550895702, 4856.2958371036, 4791.688540244873, 4857.611391088704, 4931.087748766418, 4937.456879743226, 4938.58022068121, 4833.975830120827, 4842.903141937212, 4848.830290939871, 4884.92672609904, 4893.486183950634, 4831.251156070814, 4835.395575553056, 4835.58897493717, 4847.345608342828, 4884.682495637772, 4160.750354978651, 4206.284931561642, 4228.640565551963, 4230.963413963537, 4264.530901600821, 3684.8526058957877, 3709.1283548366114, 3735.4210097434943, 3757.4551690004796, 3794.3359912015285, 4274.2092712848225, 4281.614654681093, 4286.421333119989, 4292.291771857608, 4345.174416860849, 4771.594414474739, 4907.55831975124, 4920.335754673145, 4933.260010998379, 4979.551840334315, 4269.444972153662, 4272.124214536013, 4298.957010429918, 4302.89242768927, 4312.482502099768, 4455.754933478625, 4456.04195098049, 4460.219461594208, 4460.933086003713, 4505.819767209275, 4530.161920044802, 4648.442186937589, 4650.9767451162525, 4685.367475390847, 4727.669063165546, 4898.21628539432, 4899.951000489949, 4909.459959404534, 4932.383452068491, 4940.0, 4644.3265726470145, 4647.721136731807, 4651.116287905287, 4655.83704570352, 4707.529247075265, 4567.520410356865, 4776.5701086902345, 4807.375041244616, 4838.129136755418, 4857.271409288635, 4912.828051018198, 4913.115639184838, 4929.06347793918, 4938.234573641092, 4954.727489988085, 4765.9046819064115, 4767.976160119178, 4773.0, 4775.785089670903, 4819.108464933998, 4653.418322709661, 4720.244760838249, 4756.429228492603, 4763.499832517536, 4820.590249828663, 4635.7218566886095, 4642.280446530793, 4649.651276154234, 4675.181843177363, 4679.157751604744, 4723.173444647105, 4735.076660051394, 4739.170645137018, 4784.593309568726, 4793.0413917216, 4562.908741825211, 4627.490975992706, 4632.5830675239395, 4652.185867473247, 4689.109069276827], "value": 4507.658210780137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.3289002532, 594.0050415553947, 596.3559355895632, 599.086393250293, 611.0650704422234, 22424.0, 33489.162770930736, 33754.8312258439, 33918.49122263165, 33975.15062123448, 33460.49809252863, 34176.316473670515, 34238.828805855934, 34240.48639270413, 34264.0, 6855.0, 7427.665755041036, 7694.038245219348, 9325.487098209629, 9600.375975561601, 9408.576614052385, 9620.518974051269, 9628.566714497865, 9634.951825240863, 9638.566264518113, 9539.523023848815, 9709.61161553537, 9711.465869377182, 9718.465484398355, 9718.805623887518, 6866.382025617693, 9304.534773261345, 9581.185599224074, 9585.616575336979, 9587.041295870427, 9461.290403219786, 9621.374610650286, 9622.182114520274, 9623.807523849553, 9629.662961796303, 27723.72276277252, 28148.859255703795, 28237.576436353473, 28239.57640635392, 28294.858525707445, 2985.462616728988, 3102.4105419970133, 3166.746660267173, 3314.767966242364, 3447.9310413791836, 26691.19926402211, 26693.466130677472, 26879.193624191306, 26979.460410791675, 27315.453690926268, 3459.809710465923, 3491.5460990071383, 3515.2969406118877, 3532.452469867175, 3582.0865679251883, 147857.0, 150470.9999999989, 150570.0, 150709.0, 151028.0, 42541.36187957183, 43112.56887431148, 43197.0, 43197.56802431998, 43208.56791432108, 47676.046479070916, 48278.27582586264, 48308.75845620749, 48312.5168748308, 48378.27432588514, 11362.829557556643, 12154.453049612788, 12228.75542489163, 12238.143329966995, 12271.018318534496, 10824.296420732628, 10966.396848173426, 10990.340579565252, 10997.505112269968, 11007.944960275147, 16509.422170223985, 16517.0, 16521.752173717403, 16522.339106435847, 16540.172991350384, 6452.064450654629, 6581.308962558958, 6707.5975441473665, 6712.865742685119, 6715.1941766988275, 772.729544659376, 831.7629475599425, 838.375410319316, 887.430887580451, 946.4037656276502, 25642.871785640953, 26074.34814129624, 26079.739202607732, 26197.607035894478, 26206.475870482485, 891.6344298837575, 893.8391089603933, 911.9908800912038, 961.3847137831793, 979.1334668818005, 13402.396892139877, 13794.310284485735, 13854.30728463593, 14119.717605648035, 14260.500882469063, 274325.0, 277658.0, 280441.0, 280618.0, 280643.0, 45056.0, 45936.0, 46140.0, 46141.76929115333, 46162.0, 1018.8930162332848, 1033.8914413986574, 1169.2458364355114, 1252.8496580410408, 1259.6472987563498, 23836.918335290535, 27307.453850923266, 27358.726412736414, 27813.0, 27882.16353509398, 38075.0, 38918.80540597279, 38969.80515097406, 39053.0, 39060.41409378805, 194592.0, 195747.0, 197781.1996920284, 197785.0, 204223.0, 18075.186616602547, 22146.77853221447, 22347.217847375265, 22607.20874769441, 22669.319920402413, 34959.28049713256, 35036.649633504356, 35041.12397190091, 35886.0, 36019.27961440704, 30496.0, 30867.0, 30895.382092358475, 31065.8446707765, 31432.52851207188, 25031.874840625682, 25836.095736649128, 26674.19977400681, 26724.599131012663, 27061.10572259923, 32674.0, 32999.34001320008, 33180.0, 33517.16207094842, 33700.662993369755, 29421.558676620298, 29788.255293617833, 30064.398712026075, 30432.84783576068, 30455.84772076214, 20825.89587052055, 23628.763712363343, 23758.0, 24136.275911722678, 24397.26808195757], "value": 15956.085870230112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.08556749881546, 378.98105094745256, 380.7696343712054, 385.9324618191816, 387.4807757604809, 15288.923555382222, 15376.308066137022, 16329.101899395528, 16334.34662613494, 16363.672726545477, 12921.353932303395, 14788.334524946376, 15716.292766825492, 16122.0, 16146.273417696202, 4330.523642399334, 4530.569595888385, 4566.132434837386, 4568.269076947689, 4570.0, 3419.897403077899, 4515.683902126852, 5031.295618613397, 5315.521603055724, 5342.759575819078, 5276.92084618731, 5317.9202311965155, 5328.973355133219, 5343.706096164709, 5346.599005074616, 5069.670471419365, 5298.417174110845, 5325.547328477045, 5338.3060202173665, 5339.279197308352, 3337.0823023668686, 5028.396592408898, 5148.485151484859, 5268.157094864803, 5281.867953301198, 11714.180007399485, 11847.289162650268, 11901.880981190165, 12307.75384492305, 17213.7417938731, 1846.796852346241, 1898.506388339042, 2092.801183887528, 2465.1988103866315, 2504.3864253258066, 8718.694845680371, 8768.210861022539, 8817.0, 9179.541022948826, 9270.860937085949, 1725.9741103883453, 1743.2329774899003, 1772.3619496981205, 1808.6653969015642, 1814.7368631548484, 59084.70457647727, 60163.0, 60670.089948650806, 61069.389306106816, 61371.0, 9739.464329461805, 9934.155596774355, 9969.700908972742, 9971.451570163566, 10056.74858128538, 13781.862181378057, 13893.513727019506, 13907.513237036655, 13932.303384830719, 13940.930295348458, 7189.532680375759, 7314.890276645855, 7331.596762178025, 7385.778426647209, 7576.734814281584, 6934.879304313079, 7033.261507541737, 7039.894401583981, 7044.964775176091, 7118.679659415235, 4353.956460435418, 4360.084382279757, 4432.246518091933, 4488.461384633865, 4516.36770852081, 1568.8431156884449, 1668.3910372713872, 1764.1708397053364, 1779.7953235377838, 1915.5785727140008, 795.7732046366758, 897.7441429192648, 923.7505873414275, 936.7939053408239, 942.990570094304, 14828.184449855145, 15080.321385537678, 15091.471798487, 16723.163841807862, 16822.495325140266, 759.2217976574055, 798.8082860113531, 822.4777266435856, 828.1180542721982, 862.0775769926245, 8479.06730259671, 9101.180893719596, 9233.215176710055, 9253.953730231306, 9476.241900647932, 381311.0, 386865.0, 390855.0, 393617.0, 396073.0, 66739.0, 67927.0, 68618.3138168622, 68926.65536672284, 69662.65168674226, 976.3897564022486, 978.7406337320616, 989.8861630912537, 991.0584944302941, 992.7220378294089, 14270.785938210727, 14338.856611433752, 14561.781573276621, 14600.488982885548, 15059.548213553611, 32092.83953580217, 32715.509267361485, 32814.67185328212, 33592.49611255784, 33717.83141084279, 45106.323405148294, 46239.537604623525, 46433.0, 46549.069018618764, 46731.76634116808, 7339.449541284318, 7382.224866388952, 7394.704211831681, 7407.407407407502, 7501.2123727007875, 9493.85759213626, 11424.657260282205, 11556.653300401002, 11616.12879034059, 11763.294202347886, 10132.645357412455, 10288.691339259834, 10358.689239322832, 10364.792704146026, 10479.63321283782, 8885.600147993486, 9388.0, 9479.620815167593, 10125.898741012496, 10367.844482332923, 10331.22515811302, 10412.32319899204, 10425.895741042492, 10605.522751476356, 10768.51541680642, 7529.774106776806, 7576.431767617561, 7685.846283074419, 7696.114946781192, 7817.022872140982, 9760.511974401394, 10074.848877266993, 10437.16502679799, 10492.42613607965, 10500.369977801356], "value": 7850.962716523508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1123.7696272264186, 1376.4631793600495, 1435.2895316818174, 1582.825889152193, 1766.258171567942, 6275.466585340246, 7603.543787372754, 7815.413843961712, 7828.960855195716, 7832.686692532292, 7652.3878089752825, 7657.0, 7710.460267781257, 7721.30508254257, 7741.187175346592, 1848.380792434536, 2194.2758889566485, 2213.7786221377814, 2241.607718649238, 2244.876531790751, 2244.7867452591977, 2272.136588096521, 2274.351809734226, 2276.237460450751, 2278.4873403484166, 2159.470929622245, 2172.2397160993605, 2237.4182712494785, 2242.990654205606, 2243.9439014024615, 1860.9999999999932, 2125.2455378340774, 2147.7100591420194, 2194.5172062146303, 2203.834712396577, 2195.560887822442, 2200.3179014505554, 2227.7994980451676, 2228.275810361623, 2230.609643312414, 7787.805304867367, 7796.844063118762, 7850.9214907850765, 7856.567888766115, 7873.212678732139, 4452.821887124511, 4657.953420465819, 4663.137319595886, 4664.813407463697, 4665.996810685685, 2863.2984918694847, 2879.752365261244, 2918.066218809982, 2950.734433900959, 2984.7015298470196, 866.9869951950726, 869.826034793044, 877.2762470961419, 886.9157430044136, 894.8881389826272, 10937.343759374384, 10959.452027398598, 10975.945120274348, 10984.0, 10999.175061870392, 4167.6874234432535, 4281.0, 4361.1495758327455, 4363.890902727394, 4370.847020354272, 9259.444433334022, 9319.068093190763, 9322.30082743797, 9326.300527460331, 9341.57962891658, 4710.528947105262, 4722.740249286322, 4735.621150307967, 4739.691920025188, 4740.241561350167, 3498.5626796650417, 4011.799410029545, 4144.668426525871, 4154.127633197002, 4156.854510092132, 3377.7973321600784, 3460.567429071366, 3481.2515309208643, 3518.648135186461, 3530.2057037166946, 1145.2441388683428, 1156.5200441816721, 1162.041315914374, 1167.054685704582, 1188.4295538141569, 660.5211221864206, 670.6210990790188, 687.7214728035153, 769.0156599552581, 771.0362047440699, 5039.697618142924, 5240.423553409122, 5267.367915850046, 5268.0, 5310.362756469249, 805.5529181304315, 818.43119032272, 830.4270053662954, 867.1805144138729, 879.2570278115111, 3337.5828021497314, 3383.2556837495713, 3438.707709844691, 3448.9482657760154, 3564.625714299961, 8862.556872156496, 9073.682421115229, 9239.076092390842, 9250.444973301623, 9303.25573954082, 9218.631254749735, 9511.90488095124, 9527.761805954906, 9597.47213903242, 9620.75948101303, 7410.444216683771, 7414.184439711627, 7514.586697731568, 7542.434317426215, 7600.239976002466, 5211.635185537128, 5220.347456567929, 5235.554977826775, 5298.549623282064, 5320.760565774627, 8959.552022398984, 9023.323250756088, 9308.162265396148, 9324.906750932403, 9340.206082483064, 9355.4386736796, 9357.812843743222, 9468.384555003902, 9473.431594104375, 9484.525773711424, 5394.973025134849, 6154.630722156685, 6243.719032643633, 6305.243370795534, 6417.550771445954, 7305.3425191732995, 7325.6337183141695, 7389.852202956018, 7390.704371825067, 7404.740834070997, 6082.90875636857, 6727.226368967631, 6740.528163028541, 6812.0, 6871.9312806873295, 6594.538382313384, 6649.202095748541, 6735.360140786617, 6744.460443164633, 6782.0, 6450.064740612679, 6484.962406015015, 6518.934810651833, 6523.217213934358, 6530.771423000362, 4491.079328737535, 4514.796834142406, 4649.325847752125, 4677.368555244999, 4717.3159891816185, 4643.628509719282, 4645.465771436328, 4685.6251499879245, 4800.807967681393, 4818.0], "value": 4104.097821020777, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8134956327076, 313.9058282515245, 314.18625759283464, 314.9244181396465, 317.5411530338662, 4568.451785785702, 4669.533046695329, 4715.339852420664, 4799.496052914446, 4804.423469183698, 4522.954770452295, 4681.414823147106, 4709.340692303081, 4723.055388922212, 4731.90536189276, 3748.369459285213, 3755.230177813555, 3766.6045065268163, 3773.2830762155104, 3778.433235014756, 3551.3607550640872, 3602.711783057362, 3748.3815170496837, 3780.5652349979828, 3783.905402364949, 3740.9251814963686, 3745.3071181831447, 3754.2116155607355, 3779.055236190952, 3780.6975441964714, 3708.312717713434, 3737.4393840923944, 3751.381022131345, 3753.906152346186, 3756.1548651553453, 3344.2809795893754, 3349.330133973215, 3366.259422926952, 3367.5285460035616, 3371.089805752433, 4474.437465214297, 4482.148391805546, 4541.114482675879, 4546.681732278742, 4548.545145485458, 4242.472709824461, 4248.130822438148, 4249.3413520904305, 4262.509811371701, 4279.572042795727, 4912.70523768575, 4948.331975183341, 4971.850844474671, 4974.87562810929, 4975.651704380694, 3546.7517273790845, 3636.8363423646, 3652.251288485854, 3661.5972243053243, 3669.6697297243377, 5072.315237442935, 5137.409197942247, 5143.27994080829, 5174.974125129388, 5177.741112944375, 3720.2187540616774, 3722.590515043343, 3723.2739615775204, 3727.906802329909, 3743.307488114653, 3776.263628592398, 3784.6404591563755, 3785.5268091488565, 3794.6774524165753, 3798.867039653599, 4061.1674606705556, 4204.957950420457, 4215.3044747616295, 4223.429836971969, 4250.341197114452, 4852.975735121302, 4884.511548845158, 4911.968486617779, 4928.6303527235605, 4947.233178857283, 1288.4652869059423, 1325.7812460943837, 1371.91082579634, 1384.9099808512617, 1390.4716207841159, 932.7574830544107, 945.5910693067418, 958.075457183821, 968.1818863060703, 968.2350942755145, 4646.163690535736, 4661.9976705008585, 4680.321353403738, 4695.882602934886, 4699.577038066591, 5405.162199859028, 5416.2688037114485, 5440.646357986719, 5444.557192344032, 5450.4549545045975, 4274.679399045084, 4673.0, 4675.275332323496, 4682.929756053662, 4684.95315046852, 2958.8991815811014, 2973.2864112612815, 2977.76177905767, 2984.253936515871, 2990.386970671007, 5280.419153893069, 5286.60350473716, 5310.522053015247, 5311.9734401328515, 5322.068637988414, 5074.898502029939, 5304.867378315573, 5332.999999999923, 5700.287464066992, 5715.485606295453, 4955.157623204064, 4976.576990955737, 4977.925331120036, 4979.278004689228, 4993.1262029144755, 5187.118189907649, 5240.921386179287, 5246.921296180637, 5260.631755777059, 5266.97366513165, 4802.423709154924, 5091.770870310919, 5092.923606145837, 5100.362454693163, 5108.872278193075, 4915.877103072452, 4921.384826896638, 4950.900981980412, 4951.356323678043, 4953.925691114709, 3650.926981460409, 3690.760100593453, 3701.8889433317045, 3709.9258014840093, 3715.9442608361437, 4935.975320123376, 5093.439721630543, 5203.323567936295, 5211.270422140828, 5237.240600113038, 4909.3126962224605, 4970.900581988412, 5040.621953353587, 5046.839226977889, 5048.167052436307, 5009.974950125226, 5055.16589762685, 5058.519440653132, 5060.8987820242655, 5084.2881996521255, 4830.2513110467935, 4900.803967841246, 4910.312556242057, 4957.752112394438, 4967.975160124176, 4965.702057876539, 4999.525045120708, 5012.0, 5032.723200224023, 5037.790930176658, 4885.291632713165, 4921.0, 4926.802927882988, 4927.655064145475, 4934.136526107845], "value": 3845.2015473107617, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.5031301054693, 756.5044895593388, 762.4129420346331, 779.9610019499023, 791.216695471483, 12421.254724716511, 12591.433385497652, 12666.746665066694, 12705.36473176342, 12735.872641273596, 11445.0, 12016.038716902649, 12033.21784084034, 12035.398230088504, 12079.516819327238, 534.4174849414138, 785.5954183595425, 792.8017995501125, 813.2680587471293, 822.181928980665, 812.0580127052621, 812.3501199040774, 813.9837203255931, 814.9348052155814, 815.0789607743242, 853.3173461231021, 853.5134973065324, 855.0167307596251, 855.2388374346837, 855.5593869157389, 541.6668748719549, 821.2239433735123, 847.6990668312752, 856.3534531428794, 856.618804631939, 605.9697015149225, 607.4836389069255, 608.3217212807688, 608.5344711295862, 609.0225188572322, 11817.940910295394, 11860.466279017464, 11864.88135118655, 11875.465604047838, 11875.762484750257, 11576.305421674726, 11916.523339066514, 12067.215630984047, 12128.211666241667, 12336.5065397384, 9639.951800240953, 10111.595536178544, 10135.7466063349, 10249.128824049965, 10299.073083422452, 4088.8773336799945, 4113.341865301538, 4203.516595591515, 4230.090530535949, 4318.0, 39744.40383394252, 40668.389974150414, 40691.7965410174, 40779.38830917509, 41485.96285092866, 9889.50552472388, 9972.700818975442, 10036.498175091216, 10088.142507886912, 10391.0, 17714.822851771318, 17735.379261726037, 17763.289468421117, 17764.733528997076, 17769.911150444164, 6298.0, 6382.074599183093, 6551.803445896536, 6743.730250790011, 6959.269276725972, 3733.4586484959527, 3799.848006079726, 3890.7081968851885, 3894.182221733411, 3894.2600905827803, 2824.8163869348427, 2883.0341835485347, 2883.250354907739, 2884.942301153965, 2889.4076714273524, 496.58535123172555, 500.7871654546803, 507.520393228403, 517.004363158209, 524.6799452334074, 543.7688982182557, 561.3236050559067, 572.3360901354409, 573.9110437882135, 600.5315853634172, 7596.316331530189, 7605.619719014027, 7630.694772209161, 7824.608769561499, 7843.411744119214, 549.126888247688, 574.4600075928614, 579.3916387792885, 588.7762650192899, 591.5740666719955, 3493.6681015303507, 3780.8676696316047, 3796.6583007529457, 3827.2919509890758, 3903.394973779069, 52651.73674131605, 55682.72158639262, 55734.72132639311, 55775.721121394134, 55786.44213557894, 43932.0, 44202.0, 44921.10157796826, 45538.316925246145, 45965.77017114893, 41638.583614164076, 43571.0, 44947.77526112348, 45085.294882307164, 45673.086538269046, 8010.959945200237, 8133.349332053303, 8360.916390836013, 8387.0, 8482.448640838325, 29988.400231995674, 30103.849480752455, 30355.696443035285, 30427.391452171276, 30694.0, 38093.4285985716, 40730.1853962925, 41013.0, 41206.587934120274, 41722.791386042874, 10154.111626800093, 10403.167746580104, 10459.633912813319, 10791.460426978776, 10804.297720648132, 11030.28303160292, 11123.499442525268, 11293.887061129612, 11627.476763545492, 11843.881561184278, 10694.73263168427, 10918.290311129751, 11002.50488727993, 11175.441227938409, 11536.0, 11021.44892755343, 11268.211225214156, 11534.769304614028, 11686.24039437434, 11878.287302761863, 10666.306690065121, 10778.622748203776, 11026.0, 11162.720931976766, 11325.71685707864, 9381.202597778993, 9407.576659050223, 9498.14516693501, 9518.19095376873, 9903.356281841658, 8744.344174186834, 9243.2143267823, 9255.120763527455, 9298.256139508689, 9447.055294470498], "value": 5938.789106555483, "unit": "score"}], "name": "dromaeo_css", "value": 6127.454270773014, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 109.0, 114.0, 114.0, 115.0, 102.0, 114.0, 113.0, 116.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 141.0, 165.0, 186.0, 133.0, 154.0, 156.0, 133.0, 194.0, 131.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0, 161.0, 169.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 125.0, 116.0, 74.0, 73.0, 73.0, 125.0, 108.0, 76.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 153.0, 94.0, 94.0, 94.0, 143.0, 93.0, 93.0, 153.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 64.0, 66.0, 67.0, 84.0, 65.0, 64.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 79.0, 79.0, 80.0, 85.0, 81.0, 88.0, 81.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 150.0, 147.0, 137.0, 136.0, 139.0, 135.0, 170.0, 134.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 221.0, 214.0, 213.0, 214.0, 214.0, 216.0, 217.0, 216.0, 221.0], "value": 216.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 77.0, 79.0, 74.0, 75.0, 73.0, 74.0, 75.0], "value": 75.5, "unit": "score"}], "name": "kraken", "value": 1637.7, "alertThreshold": 2.0}]} 07:18:03 INFO - Return code: 0 07:18:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:18:03 ERROR - # TBPL SUCCESS # 07:18:03 INFO - Running post-action listener: _resource_record_post_action 07:18:03 INFO - Running post-run listener: _resource_record_post_run 07:18:04 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 524476416; Read time: 160; Write time: 552704 07:18:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246140928; Read time: 0; Write time: 358928 07:18:05 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 278335488; Read time: 160; Write time: 193776 07:18:05 INFO - Running post-run listener: _upload_blobber_files 07:18:05 INFO - Blob upload gear active. 07:18:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:18:05 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:18:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:06 INFO - (blobuploader) - INFO - Done attempting. 07:18:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:18:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:06 INFO - (blobuploader) - INFO - Done attempting. 07:18:06 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:06 INFO - Return code: 0 07:18:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c29819e9c743df3547979c3dd7a44df3f0fb405b6de8bdbafc733ec4f31ec317e3b8bf6c9beeba1d9df5c1942c7ef83ed94ae15188f4dc838e6f3772dbf21ef7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99930b540dfffc75b372889b8abb67962eb8750feb229afa39aa73eaa9d34a24d6f38c04f15b69d11c1ec5553bb1895ac314023d4b8b1c0f1bb86618234d0c32"} 07:18:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:06 INFO - Contents: 07:18:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c29819e9c743df3547979c3dd7a44df3f0fb405b6de8bdbafc733ec4f31ec317e3b8bf6c9beeba1d9df5c1942c7ef83ed94ae15188f4dc838e6f3772dbf21ef7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99930b540dfffc75b372889b8abb67962eb8750feb229afa39aa73eaa9d34a24d6f38c04f15b69d11c1ec5553bb1895ac314023d4b8b1c0f1bb86618234d0c32"} 07:18:06 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:06 INFO - Copying logs to upload dir... 07:18:06 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.563455 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-26 07:18:06.223244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 07:18:06.227291) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959 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-Non-PGO/sha512/c29819e9c743df3547979c3dd7a44df3f0fb405b6de8bdbafc733ec4f31ec317e3b8bf6c9beeba1d9df5c1942c7ef83ed94ae15188f4dc838e6f3772dbf21ef7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99930b540dfffc75b372889b8abb67962eb8750feb229afa39aa73eaa9d34a24d6f38c04f15b69d11c1ec5553bb1895ac314023d4b8b1c0f1bb86618234d0c32"} build_url:https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/KKNp2tJrQauEVZcxrV-TTw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c29819e9c743df3547979c3dd7a44df3f0fb405b6de8bdbafc733ec4f31ec317e3b8bf6c9beeba1d9df5c1942c7ef83ed94ae15188f4dc838e6f3772dbf21ef7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99930b540dfffc75b372889b8abb67962eb8750feb229afa39aa73eaa9d34a24d6f38c04f15b69d11c1ec5553bb1895ac314023d4b8b1c0f1bb86618234d0c32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-26 07:18:06.256455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:18:06.256932) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1461679045.531463-1890604959 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004341 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-26 07:18:06.339451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 07:18:06.339903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-26 07:18:06.340435) ========= ========= Total master_lag: 0.17 =========