builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1464686535.19 results: success (0) buildid: 20160530234442 builduid: 4587975f5a5b44a8a822f4e4397f23c9 revision: dc4d7f68030e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.190164) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.190569) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.190838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.211289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.211646) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 02:22:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-05-31 02:22:15 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.345555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.346254) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020915 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.401899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:15.402718) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc4d7f68030e --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 dc4d7f68030e --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=78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 02:22:15,500 Setting DEBUG logging. 2016-05-31 02:22:15,500 attempt 1/10 2016-05-31 02:22:15,500 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc4d7f68030e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 02:22:15,808 unpacking tar archive at: fx-team-dc4d7f68030e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:16.048998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:16.049268) ========= script_repo_revision: dc4d7f68030e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:16.049637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:16.049906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 02:22:16.070558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-31 02:22:16.070814) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:22:16 INFO - MultiFileLogger online at 20160531 02:22:16 in /builds/slave/test 02:22:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:22:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:16 INFO - {'append_to_log': False, 02:22:16 INFO - 'base_work_dir': '/builds/slave/test', 02:22:16 INFO - 'blob_upload_branch': 'Fx-Team', 02:22:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:16 INFO - 'branch': 'Fx-Team', 02:22:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:16 INFO - 'config_files': ('talos/linux_config.py',), 02:22:16 INFO - 'default_actions': ('clobber', 02:22:16 INFO - 'read-buildbot-config', 02:22:16 INFO - 'download-and-extract', 02:22:16 INFO - 'populate-webroot', 02:22:16 INFO - 'create-virtualenv', 02:22:16 INFO - 'install', 02:22:16 INFO - 'run-tests'), 02:22:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:16 INFO - 'download_minidump_stackwalk': True, 02:22:16 INFO - 'download_symbols': 'ondemand', 02:22:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:16 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:16 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:16 INFO - 'installer_path': 'installer.exe', 02:22:16 INFO - 'log_level': 'info', 02:22:16 INFO - 'log_name': 'talos', 02:22:16 INFO - 'log_to_console': True, 02:22:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:22:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:22:16 INFO - 'opt_config_files': (), 02:22:16 INFO - 'pip_index': False, 02:22:16 INFO - 'sps_profile': False, 02:22:16 INFO - 'sps_profile_interval': 0, 02:22:16 INFO - 'suite': 'dromaeojs-e10s', 02:22:16 INFO - 'system_bits': '32', 02:22:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:16 INFO - 'title': 'talos-linux64-ix-019', 02:22:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:16 INFO - 'use_talos_json': True, 02:22:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:16 INFO - 'work_dir': 'build'} 02:22:16 INFO - ##### 02:22:16 INFO - ##### Running clobber step. 02:22:16 INFO - ##### 02:22:16 INFO - Running pre-action listener: _resource_record_pre_action 02:22:16 INFO - Running main action method: clobber 02:22:16 INFO - rmtree: /builds/slave/test/build 02:22:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:16 INFO - Running post-action listener: _resource_record_post_action 02:22:16 INFO - ##### 02:22:16 INFO - ##### Finished clobber step (success) 02:22:16 INFO - ##### 02:22:16 INFO - ##### 02:22:16 INFO - ##### Running read-buildbot-config step. 02:22:16 INFO - ##### 02:22:16 INFO - Running pre-action listener: _resource_record_pre_action 02:22:16 INFO - Running main action method: read_buildbot_config 02:22:16 INFO - Using buildbot properties: 02:22:16 INFO - { 02:22:16 INFO - "project": "", 02:22:16 INFO - "product": "firefox", 02:22:16 INFO - "script_repo_revision": "production", 02:22:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:22:16 INFO - "repository": "", 02:22:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:22:16 INFO - "buildid": "20160530234442", 02:22:16 INFO - "pgo_build": "True", 02:22:16 INFO - "basedir": "/builds/slave/test", 02:22:16 INFO - "buildnumber": 514, 02:22:16 INFO - "slavename": "talos-linux64-ix-019", 02:22:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:22:16 INFO - "platform": "ubuntu64_hw", 02:22:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:22:16 INFO - "branch": "fx-team", 02:22:16 INFO - "repo_path": "integration/fx-team", 02:22:16 INFO - "revision": "dc4d7f68030e", 02:22:16 INFO - "stage_platform": "linux64-pgo", 02:22:16 INFO - "builduid": "4587975f5a5b44a8a822f4e4397f23c9", 02:22:16 INFO - "slavebuilddir": "test" 02:22:16 INFO - } 02:22:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:22:16 INFO - Running post-action listener: _resource_record_post_action 02:22:16 INFO - ##### 02:22:16 INFO - ##### Finished read-buildbot-config step (success) 02:22:16 INFO - ##### 02:22:16 INFO - ##### 02:22:16 INFO - ##### Running download-and-extract step. 02:22:16 INFO - ##### 02:22:16 INFO - Running pre-action listener: _resource_record_pre_action 02:22:16 INFO - Running main action method: download_and_extract 02:22:16 INFO - mkdir: /builds/slave/test/build/tests 02:22:16 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')]} 02:22:16 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:22:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:22:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:22:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:26 INFO - Downloaded 1361 bytes. 02:22:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:22:26 INFO - Using the following test package requirements: 02:22:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:22:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:22:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'jsshell-linux-x86_64.zip'], 02:22:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:22:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:22:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:22:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:22:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:22:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:22:26 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')]} 02:22:26 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:29 INFO - Downloaded 24410442 bytes. 02:22:29 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'] 02:22:29 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 02:22:31 INFO - Return code: 0 02:22:31 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 02:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:31 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:22:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:38 INFO - Downloaded 24410442 bytes. 02:22:38 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'] 02:22:38 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 02:22:39 INFO - Return code: 0 02:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:39 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:22:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:40 INFO - Downloaded 10834055 bytes. 02:22:40 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'] 02:22:40 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 02:22:40 INFO - Return code: 0 02:22:40 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')]} 02:22:40 INFO - https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpFYbRizSsa-WV5sxqxvng/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 02:22:43 INFO - Downloaded 58942948 bytes. 02:22:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:43 INFO - mkdir: /builds/slave/test/properties 02:22:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:43 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:43 INFO - Contents: 02:22:43 INFO - build_url:https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:22:44 INFO - Running post-action listener: _resource_record_post_action 02:22:44 INFO - Running post-action listener: set_extra_try_arguments 02:22:44 INFO - ##### 02:22:44 INFO - ##### Finished download-and-extract step (success) 02:22:44 INFO - ##### 02:22:44 INFO - ##### 02:22:44 INFO - ##### Running populate-webroot step. 02:22:44 INFO - ##### 02:22:44 INFO - Running pre-action listener: _resource_record_pre_action 02:22:44 INFO - Running main action method: populate_webroot 02:22:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:44 INFO - '--tppagecycles', 02:22:44 INFO - '7'], 02:22:44 INFO - 'tests': ['tsvgm']}}, 02:22:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['damp', 'tps']}, 02:22:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'tests': ['damp', 'tps']}, 02:22:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['dromaeo_dom']}, 02:22:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['a11yr', 02:22:44 INFO - 'ts_paint', 02:22:44 INFO - 'tpaint', 02:22:44 INFO - 'sessionrestore', 02:22:44 INFO - 'sessionrestore_no_auto_restore', 02:22:44 INFO - 'tabpaint']}, 02:22:44 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:44 INFO - 'ts_paint', 02:22:44 INFO - 'tpaint', 02:22:44 INFO - 'sessionrestore', 02:22:44 INFO - 'sessionrestore_no_auto_restore', 02:22:44 INFO - 'tabpaint']}, 02:22:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:44 INFO - 'ts_paint', 02:22:44 INFO - 'tpaint', 02:22:44 INFO - 'sessionrestore', 02:22:44 INFO - 'sessionrestore_no_auto_restore', 02:22:44 INFO - 'tabpaint']}, 02:22:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:44 INFO - 'ts_paint', 02:22:44 INFO - 'tpaint', 02:22:44 INFO - 'sessionrestore', 02:22:44 INFO - 'sessionrestore_no_auto_restore', 02:22:44 INFO - 'tabpaint']}, 02:22:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['a11yr', 02:22:44 INFO - 'ts_paint', 02:22:44 INFO - 'tpaint', 02:22:44 INFO - 'sessionrestore', 02:22:44 INFO - 'sessionrestore_no_auto_restore', 02:22:44 INFO - 'tabpaint']}, 02:22:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['a11yr', 02:22:44 INFO - 'ts_paint', 02:22:44 INFO - 'tpaint', 02:22:44 INFO - 'sessionrestore', 02:22:44 INFO - 'sessionrestore_no_auto_restore', 02:22:44 INFO - 'tabpaint']}, 02:22:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['tsvgx', 02:22:44 INFO - 'tsvgr_opacity', 02:22:44 INFO - 'tart', 02:22:44 INFO - 'tscrollx', 02:22:44 INFO - 'cart']}, 02:22:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:44 INFO - 'tsvgr_opacity', 02:22:44 INFO - 'tart', 02:22:44 INFO - 'tscrollx', 02:22:44 INFO - 'cart']}, 02:22:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'talos_options': ['--disable-e10s'], 02:22:44 INFO - 'tests': ['tp5o']}, 02:22:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'tests': ['tp5o']}, 02:22:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'talos_options': ['--disable-e10s', 02:22:44 INFO - '--xperf_path', 02:22:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:44 INFO - 'tests': ['tp5n']}, 02:22:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:44 INFO - 'talos_options': ['--xperf_path', 02:22:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:44 INFO - 'tests': ['tp5n']}}, 02:22:44 INFO - 'talos.zip': {'path': '', 02:22:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:44 INFO - Running post-action listener: _resource_record_post_action 02:22:44 INFO - ##### 02:22:44 INFO - ##### Finished populate-webroot step (success) 02:22:44 INFO - ##### 02:22:44 INFO - ##### 02:22:44 INFO - ##### Running create-virtualenv step. 02:22:44 INFO - ##### 02:22:44 INFO - Running pre-action listener: _resource_record_pre_action 02:22:44 INFO - Running main action method: create_virtualenv 02:22:44 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:44 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 02:22:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:44 INFO - Using real prefix '/usr' 02:22:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:44 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:46 INFO - Installing pip.................done. 02:22:46 INFO - Return code: 0 02:22:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22:46 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')]} 02:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:46 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')]} 02:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:46 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 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:22:46 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 02:22:46 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 02:22:46 INFO - Using env: {'DISPLAY': ':0', 02:22:46 INFO - 'HOME': '/home/cltbld', 02:22:46 INFO - 'LANG': 'en_US.UTF-8', 02:22:46 INFO - 'LANGUAGE': 'en_US:en', 02:22:46 INFO - 'LOGNAME': 'cltbld', 02:22:46 INFO - 'MAIL': '/var/mail/cltbld', 02:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:46 INFO - 'MOZ_NO_REMOTE': '1', 02:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:46 INFO - 'NO_EM_RESTART': '1', 02:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:46 INFO - 'PWD': '/builds/slave/test', 02:22:46 INFO - 'SHELL': '/bin/bash', 02:22:46 INFO - 'SHLVL': '1', 02:22:46 INFO - 'TERM': 'linux', 02:22:46 INFO - 'TMOUT': '86400', 02:22:46 INFO - 'USER': 'cltbld', 02:22:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:46 INFO - '_': '/tools/buildbot/bin/python'} 02:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:46 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 02:22:46 INFO - Cleaning up... 02:22:46 INFO - Return code: 0 02:22:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22:46 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')]} 02:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:46 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')]} 02:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:22:46 INFO - Using env: {'DISPLAY': ':0', 02:22:46 INFO - 'HOME': '/home/cltbld', 02:22:46 INFO - 'LANG': 'en_US.UTF-8', 02:22:46 INFO - 'LANGUAGE': 'en_US:en', 02:22:46 INFO - 'LOGNAME': 'cltbld', 02:22:46 INFO - 'MAIL': '/var/mail/cltbld', 02:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:46 INFO - 'MOZ_NO_REMOTE': '1', 02:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:46 INFO - 'NO_EM_RESTART': '1', 02:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:46 INFO - 'PWD': '/builds/slave/test', 02:22:46 INFO - 'SHELL': '/bin/bash', 02:22:46 INFO - 'SHLVL': '1', 02:22:46 INFO - 'TERM': 'linux', 02:22:46 INFO - 'TMOUT': '86400', 02:22:46 INFO - 'USER': 'cltbld', 02:22:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:46 INFO - '_': '/tools/buildbot/bin/python'} 02:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:47 INFO - Downloading/unpacking psutil>=3.1.1 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:49 INFO - Installing collected packages: psutil 02:22:49 INFO - Running setup.py install for psutil 02:22:49 INFO - building 'psutil._psutil_linux' extension 02:22:49 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 02:22:49 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 02:22:49 INFO - building 'psutil._psutil_posix' extension 02:22:49 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 02:22:49 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 02:22:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:49 INFO - Successfully installed psutil 02:22:49 INFO - Cleaning up... 02:22:49 INFO - Return code: 0 02:22:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:22:49 INFO - Using env: {'DISPLAY': ':0', 02:22:49 INFO - 'HOME': '/home/cltbld', 02:22:49 INFO - 'LANG': 'en_US.UTF-8', 02:22:49 INFO - 'LANGUAGE': 'en_US:en', 02:22:49 INFO - 'LOGNAME': 'cltbld', 02:22:49 INFO - 'MAIL': '/var/mail/cltbld', 02:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:49 INFO - 'MOZ_NO_REMOTE': '1', 02:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:49 INFO - 'NO_EM_RESTART': '1', 02:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:49 INFO - 'PWD': '/builds/slave/test', 02:22:49 INFO - 'SHELL': '/bin/bash', 02:22:49 INFO - 'SHLVL': '1', 02:22:49 INFO - 'TERM': 'linux', 02:22:49 INFO - 'TMOUT': '86400', 02:22:49 INFO - 'USER': 'cltbld', 02:22:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:49 INFO - '_': '/tools/buildbot/bin/python'} 02:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:22:51 INFO - Installing collected packages: mozsystemmonitor 02:22:51 INFO - Running setup.py install for mozsystemmonitor 02:22:51 INFO - Successfully installed mozsystemmonitor 02:22:51 INFO - Cleaning up... 02:22:51 INFO - Return code: 0 02:22:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:51 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 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:22:51 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 02:22:51 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 02:22:51 INFO - Using env: {'DISPLAY': ':0', 02:22:51 INFO - 'HOME': '/home/cltbld', 02:22:51 INFO - 'LANG': 'en_US.UTF-8', 02:22:51 INFO - 'LANGUAGE': 'en_US:en', 02:22:51 INFO - 'LOGNAME': 'cltbld', 02:22:51 INFO - 'MAIL': '/var/mail/cltbld', 02:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:51 INFO - 'MOZ_NO_REMOTE': '1', 02:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:51 INFO - 'NO_EM_RESTART': '1', 02:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:51 INFO - 'PWD': '/builds/slave/test', 02:22:51 INFO - 'SHELL': '/bin/bash', 02:22:51 INFO - 'SHLVL': '1', 02:22:51 INFO - 'TERM': 'linux', 02:22:51 INFO - 'TMOUT': '86400', 02:22:51 INFO - 'USER': 'cltbld', 02:22:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:51 INFO - '_': '/tools/buildbot/bin/python'} 02:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:52 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:54 INFO - Downloading docopt-0.6.1.tar.gz 02:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:54 INFO - Running setup.py install for blobuploader 02:22:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:54 INFO - Running setup.py install for requests 02:22:55 INFO - Running setup.py install for docopt 02:22:55 INFO - Successfully installed blobuploader requests docopt 02:22:55 INFO - Cleaning up... 02:22:55 INFO - Return code: 0 02:22:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:55 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 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:22:55 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 02:22:55 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 02:22:55 INFO - Using env: {'DISPLAY': ':0', 02:22:55 INFO - 'HOME': '/home/cltbld', 02:22:55 INFO - 'LANG': 'en_US.UTF-8', 02:22:55 INFO - 'LANGUAGE': 'en_US:en', 02:22:55 INFO - 'LOGNAME': 'cltbld', 02:22:55 INFO - 'MAIL': '/var/mail/cltbld', 02:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:55 INFO - 'MOZ_NO_REMOTE': '1', 02:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:55 INFO - 'NO_EM_RESTART': '1', 02:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:55 INFO - 'PWD': '/builds/slave/test', 02:22:55 INFO - 'SHELL': '/bin/bash', 02:22:55 INFO - 'SHLVL': '1', 02:22:55 INFO - 'TERM': 'linux', 02:22:55 INFO - 'TMOUT': '86400', 02:22:55 INFO - 'USER': 'cltbld', 02:22:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:55 INFO - '_': '/tools/buildbot/bin/python'} 02:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:55 INFO - Running setup.py (path:/tmp/pip-DTJl4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:55 INFO - Running setup.py (path:/tmp/pip-2HhFjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:55 INFO - Running setup.py (path:/tmp/pip-Tix9q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:55 INFO - Running setup.py (path:/tmp/pip-dNXqiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:55 INFO - Running setup.py (path:/tmp/pip-ZmpOf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:55 INFO - Running setup.py (path:/tmp/pip-gvkHeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:56 INFO - Running setup.py (path:/tmp/pip-L8LHqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:56 INFO - Running setup.py (path:/tmp/pip-C3Px5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:56 INFO - Running setup.py (path:/tmp/pip-89Wjj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:56 INFO - Running setup.py (path:/tmp/pip-FmgM5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:56 INFO - Running setup.py (path:/tmp/pip-PbWO6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:56 INFO - Running setup.py (path:/tmp/pip-pr9jQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:56 INFO - Running setup.py (path:/tmp/pip-3Ug3fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:56 INFO - Running setup.py (path:/tmp/pip-XVN6bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:56 INFO - Running setup.py (path:/tmp/pip-mGk10o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:56 INFO - Running setup.py (path:/tmp/pip-VatLFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:56 INFO - Running setup.py (path:/tmp/pip-W0n6Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:22:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:22:56 INFO - Running setup.py install for manifestparser 02:22:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:22:56 INFO - Running setup.py install for mozcrash 02:22:56 INFO - Running setup.py install for mozdebug 02:22:57 INFO - Running setup.py install for mozdevice 02:22:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Running setup.py install for mozfile 02:22:57 INFO - Running setup.py install for mozhttpd 02:22:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Running setup.py install for mozinfo 02:22:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Running setup.py install for mozInstall 02:22:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Running setup.py install for mozleak 02:22:57 INFO - Running setup.py install for mozlog 02:22:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Running setup.py install for moznetwork 02:22:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:22:57 INFO - Running setup.py install for mozprocess 02:22:58 INFO - Running setup.py install for mozprofile 02:22:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Running setup.py install for mozrunner 02:22:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Running setup.py install for mozscreenshot 02:22:58 INFO - Running setup.py install for moztest 02:22:58 INFO - Running setup.py install for mozversion 02:22:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:22:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:22:58 INFO - Cleaning up... 02:22:58 INFO - Return code: 0 02:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:58 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 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:22:58 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 02:22:58 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 02:22:58 INFO - Using env: {'DISPLAY': ':0', 02:22:58 INFO - 'HOME': '/home/cltbld', 02:22:58 INFO - 'LANG': 'en_US.UTF-8', 02:22:58 INFO - 'LANGUAGE': 'en_US:en', 02:22:58 INFO - 'LOGNAME': 'cltbld', 02:22:58 INFO - 'MAIL': '/var/mail/cltbld', 02:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:58 INFO - 'MOZ_NO_REMOTE': '1', 02:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:58 INFO - 'NO_EM_RESTART': '1', 02:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:58 INFO - 'PWD': '/builds/slave/test', 02:22:58 INFO - 'SHELL': '/bin/bash', 02:22:58 INFO - 'SHLVL': '1', 02:22:58 INFO - 'TERM': 'linux', 02:22:58 INFO - 'TMOUT': '86400', 02:22:58 INFO - 'USER': 'cltbld', 02:22:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:58 INFO - '_': '/tools/buildbot/bin/python'} 02:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:58 INFO - Running setup.py (path:/tmp/pip-eRr0TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:58 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)) 02:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:58 INFO - Running setup.py (path:/tmp/pip-MoCQiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:58 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)) 02:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:58 INFO - Running setup.py (path:/tmp/pip-G42jxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:58 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)) 02:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:58 INFO - Running setup.py (path:/tmp/pip-SG9tp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:59 INFO - Running setup.py (path:/tmp/pip-diwLP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:59 INFO - Running setup.py (path:/tmp/pip-VXXOcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:59 INFO - Running setup.py (path:/tmp/pip-yP0Lsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:59 INFO - Running setup.py (path:/tmp/pip-kRBMtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:59 INFO - Running setup.py (path:/tmp/pip-i4h_Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:59 INFO - Running setup.py (path:/tmp/pip-w5i62A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:59 INFO - Running setup.py (path:/tmp/pip-P7ysWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:59 INFO - Running setup.py (path:/tmp/pip-Prdyab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:59 INFO - Running setup.py (path:/tmp/pip-JQ_FwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:59 INFO - Running setup.py (path:/tmp/pip-NLZ4Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:59 INFO - Running setup.py (path:/tmp/pip-_3Nt7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:22:59 INFO - Running setup.py (path:/tmp/pip-4lot5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:22:59 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)) 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:22:59 INFO - Running setup.py (path:/tmp/pip-TJo1Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 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)) 02:23:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:01 INFO - Downloading blessings-1.6.tar.gz 02:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:01 INFO - Installing collected packages: blessings 02:23:01 INFO - Running setup.py install for blessings 02:23:02 INFO - Successfully installed blessings 02:23:02 INFO - Cleaning up... 02:23:02 INFO - Return code: 0 02:23:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:02 INFO - Reading from file tmpfile_stdout 02:23:02 INFO - Current package versions: 02:23:02 INFO - argparse == 1.2.1 02:23:02 INFO - blessings == 1.6 02:23:02 INFO - blobuploader == 1.2.4 02:23:02 INFO - docopt == 0.6.1 02:23:02 INFO - manifestparser == 1.1 02:23:02 INFO - mozInstall == 1.12 02:23:02 INFO - mozcrash == 0.17 02:23:02 INFO - mozdebug == 0.1 02:23:02 INFO - mozdevice == 0.48 02:23:02 INFO - mozfile == 1.2 02:23:02 INFO - mozhttpd == 0.7 02:23:02 INFO - mozinfo == 0.9 02:23:02 INFO - mozleak == 0.1 02:23:02 INFO - mozlog == 3.2 02:23:02 INFO - moznetwork == 0.27 02:23:02 INFO - mozprocess == 0.22 02:23:02 INFO - mozprofile == 0.28 02:23:02 INFO - mozrunner == 6.11 02:23:02 INFO - mozscreenshot == 0.1 02:23:02 INFO - mozsystemmonitor == 0.3 02:23:02 INFO - moztest == 0.7 02:23:02 INFO - mozversion == 1.4 02:23:02 INFO - psutil == 3.1.1 02:23:02 INFO - requests == 1.2.3 02:23:02 INFO - wsgiref == 0.1.2 02:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:02 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 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:23:02 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 02:23:02 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 02:23:02 INFO - Using env: {'DISPLAY': ':0', 02:23:02 INFO - 'HOME': '/home/cltbld', 02:23:02 INFO - 'LANG': 'en_US.UTF-8', 02:23:02 INFO - 'LANGUAGE': 'en_US:en', 02:23:02 INFO - 'LOGNAME': 'cltbld', 02:23:02 INFO - 'MAIL': '/var/mail/cltbld', 02:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:02 INFO - 'MOZ_NO_REMOTE': '1', 02:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:02 INFO - 'NO_EM_RESTART': '1', 02:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:02 INFO - 'PWD': '/builds/slave/test', 02:23:02 INFO - 'SHELL': '/bin/bash', 02:23:02 INFO - 'SHLVL': '1', 02:23:02 INFO - 'TERM': 'linux', 02:23:02 INFO - 'TMOUT': '86400', 02:23:02 INFO - 'USER': 'cltbld', 02:23:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:02 INFO - '_': '/tools/buildbot/bin/python'} 02:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 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)) 02:23:02 INFO - Cleaning up... 02:23:02 INFO - Return code: 0 02:23:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:02 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 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:23:02 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 02:23:02 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 02:23:02 INFO - Using env: {'DISPLAY': ':0', 02:23:02 INFO - 'HOME': '/home/cltbld', 02:23:02 INFO - 'LANG': 'en_US.UTF-8', 02:23:02 INFO - 'LANGUAGE': 'en_US:en', 02:23:02 INFO - 'LOGNAME': 'cltbld', 02:23:02 INFO - 'MAIL': '/var/mail/cltbld', 02:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:02 INFO - 'MOZ_NO_REMOTE': '1', 02:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:02 INFO - 'NO_EM_RESTART': '1', 02:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:02 INFO - 'PWD': '/builds/slave/test', 02:23:02 INFO - 'SHELL': '/bin/bash', 02:23:02 INFO - 'SHLVL': '1', 02:23:02 INFO - 'TERM': 'linux', 02:23:02 INFO - 'TMOUT': '86400', 02:23:02 INFO - 'USER': 'cltbld', 02:23:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:02 INFO - '_': '/tools/buildbot/bin/python'} 02:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:02 INFO - Downloading/unpacking jsonschema 02:23:02 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 02:23:02 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 02:23:02 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 02:23:02 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 02:23:02 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 02:23:02 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 02:23:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:23:04 INFO - Downloading/unpacking functools32 (from jsonschema) 02:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:23:04 INFO - warning: no files found matching '*.txt' 02:23:04 INFO - no previously-included directories found matching 'build' 02:23:04 INFO - no previously-included directories found matching 'dist' 02:23:04 INFO - no previously-included directories found matching '.git*' 02:23:04 INFO - Installing collected packages: jsonschema, functools32 02:23:05 INFO - Running setup.py install for functools32 02:23:05 INFO - warning: no files found matching '*.txt' 02:23:05 INFO - no previously-included directories found matching 'build' 02:23:05 INFO - no previously-included directories found matching 'dist' 02:23:05 INFO - no previously-included directories found matching '.git*' 02:23:05 INFO - Successfully installed jsonschema functools32 02:23:05 INFO - Cleaning up... 02:23:05 INFO - Return code: 0 02:23:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f40ede1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2778770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', '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 02:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:23:05 INFO - Using env: {'DISPLAY': ':0', 02:23:05 INFO - 'HOME': '/home/cltbld', 02:23:05 INFO - 'LANG': 'en_US.UTF-8', 02:23:05 INFO - 'LANGUAGE': 'en_US:en', 02:23:05 INFO - 'LOGNAME': 'cltbld', 02:23:05 INFO - 'MAIL': '/var/mail/cltbld', 02:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:05 INFO - 'MOZ_NO_REMOTE': '1', 02:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:05 INFO - 'NO_EM_RESTART': '1', 02:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:05 INFO - 'PWD': '/builds/slave/test', 02:23:05 INFO - 'SHELL': '/bin/bash', 02:23:05 INFO - 'SHLVL': '1', 02:23:05 INFO - 'TERM': 'linux', 02:23:05 INFO - 'TMOUT': '86400', 02:23:05 INFO - 'USER': 'cltbld', 02:23:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:05 INFO - '_': '/tools/buildbot/bin/python'} 02:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:05 INFO - Downloading/unpacking flake8 02:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:23:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:23:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:23:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:07 INFO - no previously-included directories found matching 'docs/_build' 02:23:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:23:08 INFO - Running setup.py install for pep8 02:23:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:08 INFO - no previously-included directories found matching 'docs/_build' 02:23:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:23:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:23:08 INFO - Cleaning up... 02:23:08 INFO - Return code: 0 02:23:08 INFO - Running post-action listener: _resource_record_post_action 02:23:08 INFO - Running post-action listener: _start_resource_monitoring 02:23:08 INFO - Starting resource monitoring. 02:23:08 INFO - ##### 02:23:08 INFO - ##### Finished create-virtualenv step (success) 02:23:08 INFO - ##### 02:23:08 INFO - ##### 02:23:08 INFO - ##### Running install step. 02:23:08 INFO - ##### 02:23:08 INFO - Running pre-action listener: _resource_record_pre_action 02:23:08 INFO - Running main action method: install 02:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:08 INFO - Reading from file tmpfile_stdout 02:23:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:23:08 INFO - Reading from file tmpfile_stdout 02:23:08 INFO - Output received: 02:23:08 INFO - Usage: mozinstall [options] installer 02:23:08 INFO - Options: 02:23:08 INFO - -h, --help show this help message and exit 02:23:08 INFO - -d DEST, --destination=DEST 02:23:08 INFO - Directory to install application into. [default: 02:23:08 INFO - "/builds/slave/test"] 02:23:08 INFO - --app=APP Application being installed. [default: firefox] 02:23:08 INFO - mkdir: /builds/slave/test/build/application 02:23:08 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'] 02:23:08 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 02:23:25 INFO - Reading from file tmpfile_stdout 02:23:25 INFO - Output received: 02:23:25 INFO - /builds/slave/test/build/application/firefox/firefox 02:23:25 INFO - Running post-action listener: _resource_record_post_action 02:23:25 INFO - ##### 02:23:25 INFO - ##### Finished install step (success) 02:23:25 INFO - ##### 02:23:25 INFO - ##### 02:23:25 INFO - ##### Running run-tests step. 02:23:25 INFO - ##### 02:23:25 INFO - Running pre-action listener: _resource_record_pre_action 02:23:25 INFO - Running main action method: run_tests 02:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:25 INFO - Python 2.7.3 02:23:25 INFO - Return code: 0 02:23:25 INFO - grabbing minidump binary from tooltool 02:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28079c0>, '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 0x28088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2808d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:25 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 02:23:25 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 02:23:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:23:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:25 INFO - Return code: 0 02:23:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:23:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:23:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:23:26 INFO - Return code: 0 02:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:23:26 INFO - Using env: {'DISPLAY': ':0', 02:23:26 INFO - 'HOME': '/home/cltbld', 02:23:26 INFO - 'LANG': 'en_US.UTF-8', 02:23:26 INFO - 'LANGUAGE': 'en_US:en', 02:23:26 INFO - 'LOGNAME': 'cltbld', 02:23:26 INFO - 'MAIL': '/var/mail/cltbld', 02:23:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:26 INFO - 'MOZ_NO_REMOTE': '1', 02:23:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:26 INFO - 'NO_EM_RESTART': '1', 02:23:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:26 INFO - 'PWD': '/builds/slave/test', 02:23:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:26 INFO - 'SHELL': '/bin/bash', 02:23:26 INFO - 'SHLVL': '1', 02:23:26 INFO - 'TERM': 'linux', 02:23:26 INFO - 'TMOUT': '86400', 02:23:26 INFO - 'USER': 'cltbld', 02:23:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578', 02:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:26 INFO - '_': '/tools/buildbot/bin/python'} 02:23:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:23:26 INFO - mozversion application_buildid: 20160530234442 02:23:26 INFO - mozversion application_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 02:23:26 INFO - mozversion application_display_name: Nightly 02:23:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:26 INFO - mozversion application_name: Firefox 02:23:26 INFO - mozversion application_remotingname: firefox 02:23:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:23:26 INFO - mozversion application_vendor: Mozilla 02:23:26 INFO - mozversion application_version: 49.0a1 02:23:26 INFO - mozversion platform_buildid: 20160530234442 02:23:26 INFO - mozversion platform_changeset: dc4d7f68030e9edd22ad0bb0bd2244d047dd767d 02:23:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:23:26 INFO - mozversion platform_version: 49.0a1 02:23:26 INFO - using testdate: 1464686606 02:23:26 INFO - actual date: 1464686606 02:23:26 INFO - starting webserver on 'localhost:44458' 02:23:26 INFO - SUITE-START | Running 2 tests 02:23:26 INFO - TEST-START | dromaeo_css 02:23:26 INFO - operating with platform_type : linux_ 02:23:26 INFO - Initialising browser for dromaeo_css test... 02:23:26 INFO - TEST-INFO | started process 16168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsWPk0_/profile http://localhost:44458/getInfo.html) 02:23:31 INFO - PROCESS | 16168 | __metrics Screen width/height:1600/1200 02:23:31 INFO - PROCESS | 16168 | colorDepth:24 02:23:31 INFO - PROCESS | 16168 | Browser inner width/height: 1024/697 02:23:31 INFO - PROCESS | 16168 | __metrics 02:23:32 ERROR - PROCESS | 16168 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 02:23:33 INFO - TEST-INFO | 16168: exit 0 02:23:33 INFO - Browser initialized. 02:23:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:33 INFO - TEST-INFO | started process 16290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsWPk0_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:45 INFO - PROCESS | 16290 | RSS: Main: 166342656 02:23:45 INFO - PROCESS | 16290 | 02:24:34 INFO - PROCESS | 16290 | 1464686674780 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] 02:26:42 INFO - PROCESS | 16290 | Cycle 1(1): loaded http://localhost:44458/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44458/tests/dromaeo/cssquery-ext.html) 02:26:43 INFO - PROCESS | 16290 | RSS: Main: 170352640 02:26:43 INFO - PROCESS | 16290 | 02:29:45 INFO - PROCESS | 16290 | Cycle 1(1): loaded http://localhost:44458/tests/dromaeo/cssquery-ext.html (next: http://localhost:44458/tests/dromaeo/cssquery-jquery.html) 02:29:46 INFO - PROCESS | 16290 | RSS: Main: 169062400 02:29:46 INFO - PROCESS | 16290 | 02:32:48 INFO - PROCESS | 16290 | Cycle 1(1): loaded http://localhost:44458/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44458/tests/dromaeo/cssquery-mootools.html) 02:32:48 INFO - PROCESS | 16290 | RSS: Main: 169877504 02:32:48 INFO - PROCESS | 16290 | 02:35:50 INFO - PROCESS | 16290 | Cycle 1(1): loaded http://localhost:44458/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44458/tests/dromaeo/cssquery-prototype.html) 02:35:51 INFO - PROCESS | 16290 | RSS: Main: 167763968 02:35:51 INFO - PROCESS | 16290 | 02:38:53 INFO - PROCESS | 16290 | Cycle 1(1): loaded http://localhost:44458/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44458/tests/dromaeo/cssquery-yui.html) 02:38:54 INFO - PROCESS | 16290 | RSS: Main: 169549824 02:38:54 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | Cycle 1(1): loaded http://localhost:44458/tests/dromaeo/cssquery-yui.html (next: http://localhost:44458/tests/dromaeo/cssquery-dojo.html) 02:41:56 INFO - PROCESS | 16290 | RSS: Main: 170582016 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | __start_tp_report 02:41:56 INFO - PROCESS | 16290 | _x_x_mozilla_page_load 02:41:56 INFO - PROCESS | 16290 | _x_x_mozilla_page_load_details 02:41:56 INFO - PROCESS | 16290 | |i|pagename|runs| 02:41:56 INFO - PROCESS | 16290 | |0;dojo.html;3139.372125574885;3193.8722451101958;3198.056573310873;3230.3700778348216;3232.660570640083;5346.09116450203;5521.585881058922;5537.833864984052;5559.388467268607;5638.267025286717;5387.488188622085;5456.345238571367;5483.698396588186;5498.80754173604;5565.6104072714925;4929.334539837112;4950.455449900508;5038.294638750578;5087.51668591485;5133.537981581657;735.832809297487;5066.721330326831;5076.543111119999;5089.7964081436885;5122.078025955327;5056.26684130799;5057.595392368602;5061;5062.569681577052;5087.898242035176;5003.524665156804;5083.212102124176;5091.516305950929;5109.259157422153;5111.565516931066;5007.874803129915;5030.949690503085;5048.7223202723835;5048.7980480780725;5101.846944591668;5341.545968592674;5470.17947307903;5491.341039075297;5506.366767821672;5525.364583072917;5805.013147764848;5885.293764748258;5908.527317814564;5966.194563733884;5983.670898100603;6010.459058684739;6022.6687532185715;6032.306284777219;6034.155218269402;6096.634201947897;5602;5604.691741954191;5607.299087614089;5611.2144299798065;5630.915536266959;5957.702114894238;6027.397260274025;6044.24446944132;6074.939250607437;6152.446279834837;5835.4748072673665;5840.415958404125;5849.268841394825;5851.590388672837;5864.648121112747;5875.11873219012;5896.823095307148;5944.464998150187;5962.4633782959745;5962.522998160223;5779.855503612359;5855.648661080349;5890.14592884038;5914;5923.851903702442;5713.914291285634;5900.085486749561;5926.288845338587;5928.051511758098;5936.881262374728;4509.368688383629;4512.413386259831;4526.117407105583;4539.182947069493;4572.977135114304;3938.7636741795586;3941.231459865299;3947.388154836005;3975.5030621172355;4014.337634290368;5594.1888426177975;5627.268455100811;5649.265595472562;5655.123455864347;5661.773529058792;5896.321922978912;5988.670623115683;5994.430529099728;5994.550408719277;6001.339852616209;5563.610547261653;5660;5661.49046585801;5669.036263835158;5694.60137790359;5121.641485096007;5134.614903882224;5175.378954525481;5188.143956247252;5208.947910520922;6015.819525414245;6253.1245625612455;6257;6258.217722784652;6283.497320214372;5873.706314684334;5926.4666180044005;5960.165576819336;5962.433568810956;5981.551383646331;6082.422169893853;6088.238970128734;6115;6126.877462450815;6170.259568851767;5735.799247026334;5829.183914252093;5839.270091238595;5840.445157710011;5895.4399332063385;5977.970110149421;6002.699865006645;6065.787697430569;6075.939240607538;6125.938740612537;5771.394003629558;5851.151583020353;5858.94141058584;5883.441073098049;5919.881602368015;5650.29371328584;5763.7982670606325;5821.09772985188;5889.175515427758;5900.557458190567;5582.916256256241;5638.351589567253;5651.915221271602;5701.971490142523;5777.2200752897825;5878.059510478303;5890.941090589039;5892.852678683067;5904.3800400959;5930.584859059997;5595.720213989202;5645.322561292671;5654.3497497788285;5777.566682498746;5781.132830075522 02:41:56 INFO - PROCESS | 16290 | |1;ext.html;573.6386076771633;602.9710025763308;608.5223099866604;621.5680102328881;629.427221228682;41909.37135942959;43211.135777284435;43211.91970200743;43392.566074339244;46726.29910551345;43602.12795744083;44075.77962110193;44336.113277734425;44343;44388.77805610975;8664.0902705216;8744.081871403507;8750.34372422071;8805.075467075962;8844.646214151426;8638.611262493172;8698.347623928199;8725.912740872605;8746.956265218665;8749.47503149813;8807.73576792694;8840.823183536326;8845.73462796114;8859.778505537348;8866.069062748415;8660.956695216515;8671.479711217347;8714.085021072822;8718.258947989396;8746.912530874673;8684.305255579602;8696.869546956801;8727.738167854974;8774.605142768527;8782.209601135864;39885.20229595392;40258.79870600658;40467;40474.1905161898;40475.797621012;3086.2901532647393;3206.2144774530157;3352.6479719629574;3642.7450078494517;3922.293987082324;29371.265718356997;31404;31442.685573144205;31789.04632861018;32830.83584582086;4344.740734817909;4349.391085248068;4410.162069206873;4453.131639330332;4515.909681806345;357859.58193553577;358132;359979;360840;362221;34264.65735342664;60844.695776520835;61172.69413652903;61183.38816611866;61186.38813611807;35072.89562626251;36906.8154659225;37073.443898341546;37081.25837483235;37101.814490927914;14685.265736713121;14816.259187040605;14899.404023838924;14909.70180596382;14938.850611493746;12176.330301833306;12311.56909508163;12375.75248495043;12413.069019823368;12416.875831241572;8190.631421586043;8252.546109963889;8268.462549934235;8317.126701696356;8342.332613390914;3178.952315715266;3204.6154461464776;3214.6463888972194;3224.2100685331775;3255.511673248984;965.5027660754716;1042.6663467690266;1089.145021158387;1101.3612104979093;1219.7316590350285;30608.23479412988;31446.37107257842;31543.84228078845;31559.52660710091;31671.36657266842;1107.6012635451232;1132.9830052549053;1133.7165708572857;1141.57191053355;1159.5245949160803;16314.592135196715;16956.406525771785;16961;17066.829331706773;17264.568385790204;555406;556409;560251;564544.4182232665;565382;59532.70233648804;59583;60244.69877650672;60646;60687;1351.7499262636443;1389.8540653231466;1396.3437184523257;1401.278341654049;1409.2249262905361;28080.578791317737;29193.562096568145;29566.408671826874;29572.408551828412;29585.26036849096;47243.52756472391;48127.03745925132;48135;48185.5181448181;48220.7588962053;484203;497141;497381;499050;501200;27827.860860695568;27969.44061118807;28109.57835632508;28122.71877281283;28151.859240704485;47639.52360476351;47650.6174691271;48658;49666.50333496619;49755;41466;41688.79155604202;41820.76530967062;42293;42539;38112.809435952644;38453.80773096117;39012.609873900896;39182.6081739179;39743.403848942864;34634.48048279227;38499.80750096231;38626.80686596549;40711.59288407078;41621.583784162984;35925.82037089798;36844.447333289485;37292;37323.626763733104;37821;28186.167899086493;28281.292967675974;29547.704522954496;29679.40641187121;30025.54961675533 02:41:56 INFO - PROCESS | 16290 | |2;jquery.html;392.2938710321421;396.1403753854136;401.1595706993847;402.84289127240373;416.254903722337;18194.36319728808;19427.611447771036;19569.608607827835;19600.509987250327;20477.38567842967;18374.72437913429;19101.426957191306;19372.031398430092;19386.127624256907;19461.902690486528;5186.740662966856;5205.3233079699585;5740.483356497914;5789.305283365981;5832.445917637818;5711.685857277848;5718.399568045358;5721.742521586518;5728.083506638938;5732.742026608792;5432.619716619838;5722.7424765885635;5723.141528770697;5723.5421166306805;5729.140628905656;5531.9723401382735;5657.575681823859;5699.943000569982;5715.971125197463;5722.856928576777;5153.149730294497;5161.845144645667;5197.610179236573;5202.635815492917;5203.531682148587;13834.23911684857;13865.584032479042;13912.58262252134;17518.562035949075;22516.549669006527;2192.6601376786625;2250.81993440526;2320.454693147109;2376.584097782881;2650.2976711171555;9946.602135914554;10214.387136771817;10256.641017564349;10350.120239779628;10568.788624227549;1895.658781419344;1937.980620193794;1944.3486432045281;1980.198019801968;2000.57987822556;83569;85707.5714621429;86170.56914715386;87025;88780;10325.63860264887;10767.19246056549;10793.892061079447;10815.729606759895;10948.124150067975;14733;14761.77857332141;14834.258287085819;14904.329305181293;14921.477748278976;7464.925350746532;7741.380689544823;7842.686292548348;7939.126696063428;7993.720219792395;7406.481546291708;7491.8501629967095;7611.1627720950655;7612.010438642941;7640.312371886445;4419.42547468827;4566.360709500673;4740.336352910595;4745.169595320874;4774.976125119352;1968.3701215611154;1981.2669312354521;2010.2361102780849;2050.4668786115417;2062.7318448601586;900;961.5480724059681;989.8366769482955;1010.2473657125488;1051.0488008352454;16968.490945271416;18980;19195.424137275902;19411;19625;926.9814603708023;946.9715908522755;967.6791180039196;1009.65671671632;1012.5747186181821;10562.20783441245;10811.729706757236;10832.458377081115;10848.72878178036;10875.401852898167;477325;477426;483229;494171;497014;68079.65960170167;84670;87199;96806;100338.49830750945;1000.7147962830704;1005.788784355279;1014.9594016239415;1032.6282538286212;1033.720895358264;17219.7417038747;17503.562410939827;17517.299308028047;17564.736528952333;17812.376566820098;30062.849685752306;43307.56692433036;43462.26150953926;44140;44252.557474424844;55072.72463637656;55802.44197557973;60638.39361606327;60769;61652;7090.893636595352;8422.410431269753;8487.915120848713;8642.913570864463;8914.153155450222;12810.935945320214;13327.66680832987;13539.052266341261;13544.86455135436;13584.796228056784;11797.88202117968;11965.820512692142;12043.75912481728;12065.939670301592;12149.939250303692;11291.604793832177;11850.525978960744;11858.110641701734;11917.761644766882;12012.099092568267;12049.33728644933;12097.274163550215;12129;12260.486600247106;12351.505939762308;8502.574871256289;8547;8550.401471896908;8713.477191368538;8756.299496040174;11613.187076904873;12633.178843375152;12652;12661.240325580495;12818.871811281768 02:41:56 INFO - PROCESS | 16290 | |3;mootools.html;1466.5673626280243;1512.7125846089245;1625.2442614184401;1729.1527151695673;1755.1136675978628;8101.959490202556;8824.249938755205;8872.58038713806;9411.10594493522;9413.29400294978;8839.602217900194;9105.27157827374;9183.265338772899;9207.401518901266;9263.490508022072;2315.5716192504397;2317.640765681322;2349.3304408243566;2351.8471299365574;2363.231949616373;2292.3925159832656;2312.606856834342;2345.413646588353;2359.551685179819;2362.2676970139228;2220.2562141682556;2228.1533017453426;2232.5311684546264;2232.799048085672;2247.741509726386;2169.804717575426;2188.9562208755897;2202.8898555072265;2205.228170140454;2206.7682893296214;2164;2177.803997640204;2182.5416662500734;2240.529488807352;2277.738060123074;9088.818223635557;9094.499802510925;9116.954415227949;9138.817223655557;9189.356745027852;5139.460356662534;5240.68555886648;5245.79016839326;5246.055709972242;5258.55302299305;3223.5487031815564;3377.5946886373545;3468.2023134679166;3517.613062563116;3531.4526248431534;1069.1927594666056;1069.8983596558314;1070.5824728355947;1072.254782925867;1083.5178345636195;12954.48182072716;12969.610911672571;12971;13083.803742943768;13179;4568.360429539867;4600.769961501912;4693.601043911306;4709.034647897173;4713.363695901009;10956.726081847859;11017.11863050954;11033.558657653604;11070;11080.833787493195;5231.424543300234;5307.6019298552765;5314.22943673173;5316.043112239834;5322;4330.913381732347;4713.622910167179;4824.445188803263;4885.193942999436;4907.09218794517;4099.487564054493;4138.2894204296235;4150.252954468165;4159.313713237282;4215.325547912319;1233.5004323249098;1284.9678758031123;1290.7741145299535;1298.701298701304;1298.8571257161705;913.3789023464108;922.9630814767335;923.3398120343986;932.5477143585356;960.9951950240344;5809.912851307234;5854.443827836349;5922.526197904243;5995.160677505153;6046.123312119718;408.47306974003203;414.5812729143587;416.4897999950098;422.10303105899965;423.8241129931106;3971.841126354971;3988.3818008208773;4008.218397412535;4051.8987025324604;4120.093579412524;11206.775864482664;11468.13988950832;11549.88450115505;11597.594084207012;11707.531698732126;11523.250988685708;11544.653660390202;11613.59352422678;11618.360990145455;11651.126165537618;8201.22088401601;8646.697365592174;8668.089850565726;8718.520481373458;8720.040795512488;5592.105263157875;5634.267545219095;5734.54123670097;5775.422457754191;5782.959067367914;10690.62582809598;10716.892831071902;10780.946095269474;10810.891891080988;10877.021068103908;10589.258751887293;10778.730531736455;10954.616588419367;10971.615993440191;11099.72250693739;7328.083989501312;7666.769996900102;7866.488678235896;8029.357651387758;8089.271965523131;8868.11318868108;8892;8899.822003559762;8907.910920890708;8920;7797.922020779946;7835.216478352119;7996.800079998046;8029.518228906284;8113.432059755761;7863.724769633264;8001.8399632008195;8011.43919925623;8120.593970301343;8121.75634730959;6660.56706314088;6691.76578819739;6718.966405167943;6763.425108865801;6765.086713293839;4769.284607308931;4796.376471058879;4852.611791056777;4862.440819305825;4919.704817710949;4722.834700785456;4752.097101550694;4774.307725379731;4821.879453013703;4837.782299796448 02:41:56 INFO - PROCESS | 16290 | |4;prototype.html;301.95772591837147;304.41704136578454;305.2095073758964;317.4745795708103;320.92297848516347;5569.721513924303;5575.191597218401;5579.69311687857;5594.608377413578;5602.691851948146;5495.450454954503;5502.697351645658;5512.6968016759065;5520.6687598744;5527.723613819313;4053.310937140693;4155.940235240025;4259.744415335074;4266.893327666802;4270.210011147932;4244.662931176685;4249.150169966004;4251.385397980251;4251.8511852085185;4284.378765079062;4211.284081706117;4215.262329092412;4215.831366745342;4229.703920725535;4238.830446782125;3978;4215.852445164404;4217.8312867485265;4219.767912764797;4219.810108545123;3614.36748569002;3674.5590529136675;3679.1721862580707;3714.572824125233;3715.7584756990977;5335.81231695007;5386.48828361305;5390.73046347685;5426.457354264581;5429.8325859939905;4596.287575425815;4874.683145595525;4887.993883761496;4898.779554920002;4940.851774446773;5749.82750517481;5773.134029895549;5773.624714393551;5798.9130163047585;5800.477956983849;4101.712880098395;4118.670506359514;4119.732217405859;4121.876343709693;4128.277551428518;5831.31407731147;6037.818865434;6055.878882422327;6081.361457046991;6140.171076904606;4153.605407486284;4169.1661667665985;4179.540250572434;4181.121964387452;4184.581541845852;4176.081262122329;4235.682323825726;4238.427812245307;4259.701820872509;4273;4726.172919739032;4801.255805350176;4820.975895120502;4919.425783749238;4947.985662939089;5803.332616749043;5834.941650583524;5857.560682948796;5858.531317494675;5878.764849406061;1443.5741456270425;1452.0996981871097;1455.9272036398138;1461.1379286221181;1473.4769156949344;924.2375040591539;936.3679516326453;955.2071780422233;957.4446820843893;991.7173605522391;5507;5522.723863806794;5593.888122237532;5597.692126932976;5609.467100625434;5878.382769809194;5911.9113213301835;5942.732577034044;5949.613275137102;5952.940470595238;5338.745394832211;5570.220169176318;5571.526420254243;5602.299712535933;5602.943970560324;3170.952435713466;3178.094243140694;3194.632617249;3196.3447493263825;3198.2324242181708;5955.34491205967;6154.723037463235;6162.7226774795245;6164.137020817089;6171.47542458896;5956.821295361146;6024.855277497261;6027.517798576104;6039.849003774941;6041.305249896318;6034.24571928509;6072.453479186983;6094.421030002142;6120.418560236771;6135.723892424851;5634.774609015593;5857;5880.588358815013;5920.851978700567;5937.3468918418075;5852.824415267549;5910.349861515144;5912.852178695395;5912.911306330495;5918.674472903859;6056.06131049688;6151.415615516519;6166.660833654192;6188.752449901954;6218.968905155445;4159.708820382544;4175.227582897173;4180.853670121531;4182.728122672017;4183.748975061506;5956.195913551615;5959.433853783884;5973.283206015306;5980.581359304981;5997.850053748692;5546.833594992157;5722.284714410699;5803.216565763737;5805.796797112081;5831.970840145772;5747.770089196552;5793.884122317614;5820.73806678692;5829.854253643693;5848.298204215522;5433.701146436984;5469.808556700496;5646.2942132233475;5658.962773401655;5671.262735844314;5792.160136780228;5794.304683438015;5866.384029676993;5888.735006924784;5910.674912879833;5558;5692.31692196939;5741.74162162712;5778.479936805707;5822.5633077518505 02:41:56 INFO - PROCESS | 16290 | |5;yui.html;695.5305169010917;789;793.6706266899237;800.1318569352248;811.1077814404156;14225.857741422582;14684.898632602557;14887.404503819862;14933.104013759183;14971.101733895961;13033.478660853554;13602.115862468932;13763.38064787087;13807.585772426843;13860.099093558913;800.5997001499236;809.2029351089172;810.8864758933724;811.6875003123811;816.9468984516017;810.5217921426357;813.9755807325789;814.2142832166958;814.3973459639853;815.5106935838479;858.7853036740814;859.7850537365658;861.3281640320529;861.9569021548898;862.8533149364623;858.7037472072125;859.1408591408591;860.2214995429147;861.2076889261831;863.0247819963464;630.2059405149499;630.6720505337245;631.5263552335748;631.6052467207995;632.2413104274842;13049.804252936214;13091.803622945663;13111.2133272004;13113.409896554582;13171.209727416386;11735.520755654983;11787.115966302561;11788.705282367924;11945.581904633296;12032.51869925202;10143.239257055677;10187.47368681742;10210;10310.381377117323;10331.58673653053;3607.3326434609417;3672.375696131664;3676.0809797550614;3706.0734816295926;3749.062734316421;54558.727206364114;54949;55139;55487.72256138734;59550.40449595492;8985.685501007434;9050.954745226363;9071.27429805614;9140.177384035336;9222.170004699476;17401.738973915402;17645.558861028578;17663.91168044177;17741.556461088578;17903.910480447776;7708.267714567107;7859;7947.5231486111015;7964.283214510722;8028.237317454832;4315.6763242756915;4338.60952514269;4410.911781764411;4433.955660443419;4439.844605438794;3129.7339726123078;3131.4989601663624;3246.62663793662;3247.821369824635;3259.152620318734;593.1695626123461;628.1551313483358;639.7057353617295;642.0369445831253;655.6459511863636;592.4549414538635;628.9748410063638;631.4474834519796;670.191895955943;702.9543079699803;9614.18279446241;9778.559964801601;9813.558389872473;9854.901450985542;9889.456079915673;572.6964708704394;652.6214795418646;684.3669605614787;723.5007844587218;760.1030783675316;4400.405945197422;4554.544545545419;4611.100835337077;4642.2340313847835;4748.928766068511;78264;78304.60847695725;80121;80876.59561702154;81004.59497702592;46430.76784616123;54817.17774233389;60202.397976020555;67542;71099;55411;56118.438815612135;56826.14760778592;57562.136567951515;57830.13254801181;9347.065293470598;9527.57125929321;9609.711708648752;9632.47021413829;9704;35506;35783;36349.818250908575;36670.8166459166;37002.074948126516;43551.78224108859;46115.76942115402;47225.7638711818;49183.262251066975;50241.748791255806;12109.687253300344;12129.636110916686;12147;12445;12485.75028499443;13258.53595124166;13374.13068150567;13924.695216319047;13926.721465570834;14369.425222990963;12182.451789669309;12560.623181304576;12625;13075.411606477921;13092.738145237232;13178.143420677625;13423.865761342262;13441.260730659907;13541.864581354454;14207.715845683235;12387.706387488428;12616.432260548114;13004.869951300367;13185.802212967004;13370;9250.537473126182;9311.627534898527;9527.28545359087;9759.512024398893;10430.11344035735;9830.705078847646;10351.741206469596;10356.585736570754;10564.471776410996;10770.892291076989 02:41:56 INFO - PROCESS | 16290 | __end_tp_report 02:41:56 INFO - PROCESS | 16290 | __start_cc_report 02:41:56 INFO - PROCESS | 16290 | _x_x_mozilla_cycle_collect,355 02:41:56 INFO - PROCESS | 16290 | __end_cc_report 02:41:56 INFO - PROCESS | 16290 | __startTimestamp1464687716923__endTimestamp 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | ------- Summary: start ------- 02:41:56 INFO - PROCESS | 16290 | Number of tests: 6 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | [#0] dojo.html Cycles:165 Average:5492.12 Median:5713.91 stddev:737.40 (12.9%) stddev-sans-first:716.19 02:41:56 INFO - PROCESS | 16290 | Values: 3139.4 3193.9 3198.1 3230.4 3232.7 5346.1 5521.6 5537.8 5559.4 5638.3 5387.5 5456.3 5483.7 5498.8 5565.6 4929.3 4950.5 5038.3 5087.5 5133.5 735.8 5066.7 5076.5 5089.8 5122.1 5056.3 5057.6 5061.0 5062.6 5087.9 5003.5 5083.2 5091.5 5109.3 5111.6 5007.9 5030.9 5048.7 5048.8 5101.8 5341.5 5470.2 5491.3 5506.4 5525.4 5805.0 5885.3 5908.5 5966.2 5983.7 6010.5 6022.7 6032.3 6034.2 6096.6 5602.0 5604.7 5607.3 5611.2 5630.9 5957.7 6027.4 6044.2 6074.9 6152.4 5835.5 5840.4 5849.3 5851.6 5864.6 5875.1 5896.8 5944.5 5962.5 5962.5 5779.9 5855.6 5890.1 5914.0 5923.9 5713.9 5900.1 5926.3 5928.1 5936.9 4509.4 4512.4 4526.1 4539.2 4573.0 3938.8 3941.2 3947.4 3975.5 4014.3 5594.2 5627.3 5649.3 5655.1 5661.8 5896.3 5988.7 5994.4 5994.6 6001.3 5563.6 5660.0 5661.5 5669.0 5694.6 5121.6 5134.6 5175.4 5188.1 5208.9 6015.8 6253.1 6257.0 6258.2 6283.5 5873.7 5926.5 5960.2 5962.4 5981.6 6082.4 6088.2 6115.0 6126.9 6170.3 5735.8 5829.2 5839.3 5840.4 5895.4 5978.0 6002.7 6065.8 6075.9 6125.9 5771.4 5851.2 5858.9 5883.4 5919.9 5650.3 5763.8 5821.1 5889.2 5900.6 5582.9 5638.4 5651.9 5702.0 5777.2 5878.1 5890.9 5892.9 5904.4 5930.6 5595.7 5645.3 5654.3 5777.6 5781.1 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | [#1] ext.html Cycles:180 Average:61404.91 Median:40470.60 stddev:127694.31 (315.5%) stddev-sans-first:127970.85 02:41:56 INFO - PROCESS | 16290 | Values: 573.6 603.0 608.5 621.6 629.4 41909.4 43211.1 43211.9 43392.6 46726.3 43602.1 44075.8 44336.1 44343.0 44388.8 8664.1 8744.1 8750.3 8805.1 8844.6 8638.6 8698.3 8725.9 8747.0 8749.5 8807.7 8840.8 8845.7 8859.8 8866.1 8661.0 8671.5 8714.1 8718.3 8746.9 8684.3 8696.9 8727.7 8774.6 8782.2 39885.2 40258.8 40467.0 40474.2 40475.8 3086.3 3206.2 3352.6 3642.7 3922.3 29371.3 31404.0 31442.7 31789.0 32830.8 4344.7 4349.4 4410.2 4453.1 4515.9 357859.6 358132.0 359979.0 360840.0 362221.0 34264.7 60844.7 61172.7 61183.4 61186.4 35072.9 36906.8 37073.4 37081.3 37101.8 14685.3 14816.3 14899.4 14909.7 14938.9 12176.3 12311.6 12375.8 12413.1 12416.9 8190.6 8252.5 8268.5 8317.1 8342.3 3179.0 3204.6 3214.6 3224.2 3255.5 965.5 1042.7 1089.1 1101.4 1219.7 30608.2 31446.4 31543.8 31559.5 31671.4 1107.6 1133.0 1133.7 1141.6 1159.5 16314.6 16956.4 16961.0 17066.8 17264.6 555406.0 556409.0 560251.0 564544.4 565382.0 59532.7 59583.0 60244.7 60646.0 60687.0 1351.7 1389.9 1396.3 1401.3 1409.2 28080.6 29193.6 29566.4 29572.4 29585.3 47243.5 48127.0 48135.0 48185.5 48220.8 484203.0 497141.0 497381.0 499050.0 501200.0 27827.9 27969.4 28109.6 28122.7 28151.9 47639.5 47650.6 48658.0 49666.5 49755.0 41466.0 41688.8 41820.8 42293.0 42539.0 38112.8 38453.8 39012.6 39182.6 39743.4 34634.5 38499.8 38626.8 40711.6 41621.6 35925.8 36844.4 37292.0 37323.6 37821.0 28186.2 28281.3 29547.7 29679.4 30025.5 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | [#2] jquery.html Cycles:180 Average:28706.88 Median:12418.50 stddev:80203.87 (645.8%) stddev-sans-first:80400.68 02:41:56 INFO - PROCESS | 16290 | Values: 392.3 396.1 401.2 402.8 416.3 18194.4 19427.6 19569.6 19600.5 20477.4 18374.7 19101.4 19372.0 19386.1 19461.9 5186.7 5205.3 5740.5 5789.3 5832.4 5711.7 5718.4 5721.7 5728.1 5732.7 5432.6 5722.7 5723.1 5723.5 5729.1 5532.0 5657.6 5699.9 5716.0 5722.9 5153.1 5161.8 5197.6 5202.6 5203.5 13834.2 13865.6 13912.6 17518.6 22516.5 2192.7 2250.8 2320.5 2376.6 2650.3 9946.6 10214.4 10256.6 10350.1 10568.8 1895.7 1938.0 1944.3 1980.2 2000.6 83569.0 85707.6 86170.6 87025.0 88780.0 10325.6 10767.2 10793.9 10815.7 10948.1 14733.0 14761.8 14834.3 14904.3 14921.5 7464.9 7741.4 7842.7 7939.1 7993.7 7406.5 7491.9 7611.2 7612.0 7640.3 4419.4 4566.4 4740.3 4745.2 4775.0 1968.4 1981.3 2010.2 2050.5 2062.7 900.0 961.5 989.8 1010.2 1051.0 16968.5 18980.0 19195.4 19411.0 19625.0 927.0 947.0 967.7 1009.7 1012.6 10562.2 10811.7 10832.5 10848.7 10875.4 477325.0 477426.0 483229.0 494171.0 497014.0 68079.7 84670.0 87199.0 96806.0 100338.5 1000.7 1005.8 1015.0 1032.6 1033.7 17219.7 17503.6 17517.3 17564.7 17812.4 30062.8 43307.6 43462.3 44140.0 44252.6 55072.7 55802.4 60638.4 60769.0 61652.0 7090.9 8422.4 8487.9 8642.9 8914.2 12810.9 13327.7 13539.1 13544.9 13584.8 11797.9 11965.8 12043.8 12065.9 12149.9 11291.6 11850.5 11858.1 11917.8 12012.1 12049.3 12097.3 12129.0 12260.5 12351.5 8502.6 8547.0 8550.4 8713.5 8756.3 11613.2 12633.2 12652.0 12661.2 12818.9 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | [#3] mootools.html Cycles:180 Average:5926.81 Median:4449.64 stddev:3553.28 (79.9%) stddev-sans-first:3547.44 02:41:56 INFO - PROCESS | 16290 | Values: 1466.6 1512.7 1625.2 1729.2 1755.1 8102.0 8824.2 8872.6 9411.1 9413.3 8839.6 9105.3 9183.3 9207.4 9263.5 2315.6 2317.6 2349.3 2351.8 2363.2 2292.4 2312.6 2345.4 2359.6 2362.3 2220.3 2228.2 2232.5 2232.8 2247.7 2169.8 2189.0 2202.9 2205.2 2206.8 2164.0 2177.8 2182.5 2240.5 2277.7 9088.8 9094.5 9117.0 9138.8 9189.4 5139.5 5240.7 5245.8 5246.1 5258.6 3223.5 3377.6 3468.2 3517.6 3531.5 1069.2 1069.9 1070.6 1072.3 1083.5 12954.5 12969.6 12971.0 13083.8 13179.0 4568.4 4600.8 4693.6 4709.0 4713.4 10956.7 11017.1 11033.6 11070.0 11080.8 5231.4 5307.6 5314.2 5316.0 5322.0 4330.9 4713.6 4824.4 4885.2 4907.1 4099.5 4138.3 4150.3 4159.3 4215.3 1233.5 1285.0 1290.8 1298.7 1298.9 913.4 923.0 923.3 932.5 961.0 5809.9 5854.4 5922.5 5995.2 6046.1 408.5 414.6 416.5 422.1 423.8 3971.8 3988.4 4008.2 4051.9 4120.1 11206.8 11468.1 11549.9 11597.6 11707.5 11523.3 11544.7 11613.6 11618.4 11651.1 8201.2 8646.7 8668.1 8718.5 8720.0 5592.1 5634.3 5734.5 5775.4 5783.0 10690.6 10716.9 10780.9 10810.9 10877.0 10589.3 10778.7 10954.6 10971.6 11099.7 7328.1 7666.8 7866.5 8029.4 8089.3 8868.1 8892.0 8899.8 8907.9 8920.0 7797.9 7835.2 7996.8 8029.5 8113.4 7863.7 8001.8 8011.4 8120.6 8121.8 6660.6 6691.8 6719.0 6763.4 6765.1 4769.3 4796.4 4852.6 4862.4 4919.7 4722.8 4752.1 4774.3 4821.9 4837.8 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | [#4] prototype.html Cycles:180 Average:4855.68 Median:5577.44 stddev:1450.02 (26.0%) stddev-sans-first:1413.24 02:41:56 INFO - PROCESS | 16290 | Values: 302.0 304.4 305.2 317.5 320.9 5569.7 5575.2 5579.7 5594.6 5602.7 5495.5 5502.7 5512.7 5520.7 5527.7 4053.3 4155.9 4259.7 4266.9 4270.2 4244.7 4249.2 4251.4 4251.9 4284.4 4211.3 4215.3 4215.8 4229.7 4238.8 3978.0 4215.9 4217.8 4219.8 4219.8 3614.4 3674.6 3679.2 3714.6 3715.8 5335.8 5386.5 5390.7 5426.5 5429.8 4596.3 4874.7 4888.0 4898.8 4940.9 5749.8 5773.1 5773.6 5798.9 5800.5 4101.7 4118.7 4119.7 4121.9 4128.3 5831.3 6037.8 6055.9 6081.4 6140.2 4153.6 4169.2 4179.5 4181.1 4184.6 4176.1 4235.7 4238.4 4259.7 4273.0 4726.2 4801.3 4821.0 4919.4 4948.0 5803.3 5834.9 5857.6 5858.5 5878.8 1443.6 1452.1 1455.9 1461.1 1473.5 924.2 936.4 955.2 957.4 991.7 5507.0 5522.7 5593.9 5597.7 5609.5 5878.4 5911.9 5942.7 5949.6 5952.9 5338.7 5570.2 5571.5 5602.3 5602.9 3171.0 3178.1 3194.6 3196.3 3198.2 5955.3 6154.7 6162.7 6164.1 6171.5 5956.8 6024.9 6027.5 6039.8 6041.3 6034.2 6072.5 6094.4 6120.4 6135.7 5634.8 5857.0 5880.6 5920.9 5937.3 5852.8 5910.3 5912.9 5912.9 5918.7 6056.1 6151.4 6166.7 6188.8 6219.0 4159.7 4175.2 4180.9 4182.7 4183.7 5956.2 5959.4 5973.3 5980.6 5997.9 5546.8 5722.3 5803.2 5805.8 5832.0 5747.8 5793.9 5820.7 5829.9 5848.3 5433.7 5469.8 5646.3 5659.0 5671.3 5792.2 5794.3 5866.4 5888.7 5910.7 5558.0 5692.3 5741.7 5778.5 5822.6 02:41:56 INFO - PROCESS | 16290 | 02:41:56 INFO - PROCESS | 16290 | [#5] yui.html Cycles:180 Average:15592.77 Median:52400.24 stddev:19618.92 (37.4%) stddev-sans-first:19642.06 02:41:56 INFO - PROCESS | 16290 | Values: 695.5 789.0 793.7 800.1 811.1 14225.9 14684.9 14887.4 14933.1 14971.1 13033.5 13602.1 13763.4 13807.6 13860.1 800.6 809.2 810.9 811.7 816.9 810.5 814.0 814.2 814.4 815.5 858.8 859.8 861.3 862.0 862.9 858.7 859.1 860.2 861.2 863.0 630.2 630.7 631.5 631.6 632.2 13049.8 13091.8 13111.2 13113.4 13171.2 11735.5 11787.1 11788.7 11945.6 12032.5 10143.2 10187.5 10210.0 10310.4 10331.6 3607.3 3672.4 3676.1 3706.1 3749.1 54558.7 54949.0 55139.0 55487.7 59550.4 8985.7 9051.0 9071.3 9140.2 9222.2 17401.7 17645.6 17663.9 17741.6 17903.9 7708.3 7859.0 7947.5 7964.3 8028.2 4315.7 4338.6 4410.9 4434.0 4439.8 3129.7 3131.5 3246.6 3247.8 3259.2 593.2 628.2 639.7 642.0 655.6 592.5 629.0 631.4 670.2 703.0 9614.2 9778.6 9813.6 9854.9 9889.5 572.7 652.6 684.4 723.5 760.1 4400.4 4554.5 4611.1 4642.2 4748.9 78264.0 78304.6 80121.0 80876.6 81004.6 46430.8 54817.2 60202.4 67542.0 71099.0 55411.0 56118.4 56826.1 57562.1 57830.1 9347.1 9527.6 9609.7 9632.5 9704.0 35506.0 35783.0 36349.8 36670.8 37002.1 43551.8 46115.8 47225.8 49183.3 50241.7 12109.7 12129.6 12147.0 12445.0 12485.8 13258.5 13374.1 13924.7 13926.7 14369.4 12182.5 12560.6 12625.0 13075.4 13092.7 13178.1 13423.9 13441.3 13541.9 14207.7 12387.7 12616.4 13004.9 13185.8 13370.0 9250.5 9311.6 9527.3 9759.5 10430.1 9830.7 10351.7 10356.6 10564.5 10770.9 02:41:56 INFO - PROCESS | 16290 | -------- Summary: end -------- 02:41:56 INFO - PROCESS | 16290 | 02:41:57 INFO - TEST-INFO | 16290: exit 0 02:41:57 INFO - TEST-OK | dromaeo_css | took 1111158ms 02:41:57 INFO - TEST-START | kraken 02:41:57 INFO - operating with platform_type : linux_ 02:41:57 INFO - Initialising browser for kraken test... 02:41:57 INFO - TEST-INFO | started process 16523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKOv2b/profile http://localhost:44458/getInfo.html) 02:42:02 INFO - PROCESS | 16523 | __metrics Screen width/height:1600/1200 02:42:02 INFO - PROCESS | 16523 | colorDepth:24 02:42:02 INFO - PROCESS | 16523 | Browser inner width/height: 1024/697 02:42:02 INFO - PROCESS | 16523 | __metrics 02:42:03 ERROR - PROCESS | 16523 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 02:42:03 INFO - TEST-INFO | 16523: exit 0 02:42:03 INFO - Browser initialized. 02:42:03 INFO - Running cycle 1/1 for kraken test... 02:42:04 INFO - TEST-INFO | started process 16641 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnKOv2b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:15 INFO - PROCESS | 16641 | RSS: Main: 166428672 02:42:15 INFO - PROCESS | 16641 | 02:42:18 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44458/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:19 INFO - PROCESS | 16641 | RSS: Main: 171687936 02:42:19 INFO - PROCESS | 16641 | 02:42:21 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44458/tests/kraken/driver.html?testName=audio-dft) 02:42:22 INFO - PROCESS | 16641 | RSS: Main: 171171840 02:42:22 INFO - PROCESS | 16641 | 02:42:25 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44458/tests/kraken/driver.html?testName=audio-fft) 02:42:26 INFO - PROCESS | 16641 | RSS: Main: 165601280 02:42:26 INFO - PROCESS | 16641 | 02:42:28 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44458/tests/kraken/driver.html?testName=audio-oscillator) 02:42:29 INFO - PROCESS | 16641 | RSS: Main: 166670336 02:42:29 INFO - PROCESS | 16641 | 02:42:31 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44458/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:31 INFO - PROCESS | 16641 | RSS: Main: 167002112 02:42:31 INFO - PROCESS | 16641 | 02:42:34 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44458/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:35 INFO - PROCESS | 16641 | RSS: Main: 167395328 02:42:35 INFO - PROCESS | 16641 | 02:42:39 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44458/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:39 INFO - PROCESS | 16641 | RSS: Main: 165072896 02:42:39 INFO - PROCESS | 16641 | 02:42:42 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44458/tests/kraken/driver.html?testName=json-parse-financial) 02:42:43 INFO - PROCESS | 16641 | RSS: Main: 166612992 02:42:43 INFO - PROCESS | 16641 | 02:42:44 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44458/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:45 INFO - PROCESS | 16641 | RSS: Main: 166903808 02:42:45 INFO - PROCESS | 16641 | 02:42:47 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:47 INFO - PROCESS | 16641 | RSS: Main: 167153664 02:42:47 INFO - PROCESS | 16641 | 02:42:49 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:50 INFO - PROCESS | 16641 | RSS: Main: 167653376 02:42:50 INFO - PROCESS | 16641 | 02:42:53 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:42:53 INFO - PROCESS | 16641 | RSS: Main: 167415808 02:42:53 INFO - PROCESS | 16641 | 02:42:56 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:42:57 INFO - PROCESS | 16641 | RSS: Main: 167260160 02:42:57 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | Cycle 1(1): loaded http://localhost:44458/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44458/tests/kraken/driver.html?testName=ai-astar) 02:42:58 INFO - PROCESS | 16641 | RSS: Main: 168124416 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | __start_tp_report 02:42:58 INFO - PROCESS | 16641 | _x_x_mozilla_page_load 02:42:58 INFO - PROCESS | 16641 | _x_x_mozilla_page_load_details 02:42:58 INFO - PROCESS | 16641 | |i|pagename|runs| 02:42:58 INFO - PROCESS | 16641 | |0;ai-astar;110;105;112;111;111;112;111;112;111;113 02:42:58 INFO - PROCESS | 16641 | |1;audio-beat-detection;149;124;156;179;128;159;160;128;191;128 02:42:58 INFO - PROCESS | 16641 | |2;audio-dft;160;162;163;161;162;163;170;160;162;160 02:42:58 INFO - PROCESS | 16641 | |3;audio-fft;75;74;76;157;76;84;75;75;162;77 02:42:58 INFO - PROCESS | 16641 | |4;audio-oscillator;85;84;147;83;83;84;148;84;83;140 02:42:58 INFO - PROCESS | 16641 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;118;118;117 02:42:58 INFO - PROCESS | 16641 | |6;imaging-darkroom;147;146;146;147;147;146;146;151;147;146 02:42:58 INFO - PROCESS | 16641 | |7;imaging-desaturate;96;95;96;96;95;95;95;96;95;95 02:42:58 INFO - PROCESS | 16641 | |8;json-parse-financial;57;54;58;55;58;55;57;55;55;54 02:42:58 INFO - PROCESS | 16641 | |9;json-stringify-tinderbox;62;63;63;63;63;62;63;63;63;63 02:42:58 INFO - PROCESS | 16641 | |10;stanford-crypto-aes;84;80;85;80;81;82;83;80;120;82 02:42:58 INFO - PROCESS | 16641 | |11;stanford-crypto-ccm;138;122;123;129;119;134;119;133;127;126 02:42:58 INFO - PROCESS | 16641 | |12;stanford-crypto-pbkdf2;166;161;163;167;160;160;165;160;163;160 02:42:58 INFO - PROCESS | 16641 | |13;stanford-crypto-sha256-iterative;65;63;65;62;63;62;62;63;64;61 02:42:58 INFO - PROCESS | 16641 | __end_tp_report 02:42:58 INFO - PROCESS | 16641 | __start_cc_report 02:42:58 INFO - PROCESS | 16641 | _x_x_mozilla_cycle_collect,914 02:42:58 INFO - PROCESS | 16641 | __end_cc_report 02:42:58 INFO - PROCESS | 16641 | __startTimestamp1464687778959__endTimestamp 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | ------- Summary: start ------- 02:42:58 INFO - PROCESS | 16641 | Number of tests: 14 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.20 (2.0%) stddev-sans-first:2.32 02:42:58 INFO - PROCESS | 16641 | Values: 110.0 105.0 112.0 111.0 111.0 112.0 111.0 112.0 111.0 113.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:157.50 stddev:23.26 (14.8%) stddev-sans-first:24.66 02:42:58 INFO - PROCESS | 16641 | Values: 149.0 124.0 156.0 179.0 128.0 159.0 160.0 128.0 191.0 128.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.95 (1.8%) stddev-sans-first:3.00 02:42:58 INFO - PROCESS | 16641 | Values: 160.0 162.0 163.0 161.0 162.0 163.0 170.0 160.0 162.0 160.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.50 stddev:35.13 (46.5%) stddev-sans-first:36.64 02:42:58 INFO - PROCESS | 16641 | Values: 75.0 74.0 76.0 157.0 76.0 84.0 75.0 75.0 162.0 77.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:83.50 stddev:29.68 (35.5%) stddev-sans-first:30.83 02:42:58 INFO - PROCESS | 16641 | Values: 85.0 84.0 147.0 83.0 83.0 84.0 148.0 84.0 83.0 140.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:42:58 INFO - PROCESS | 16641 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.52 (1.0%) stddev-sans-first:1.62 02:42:58 INFO - PROCESS | 16641 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 151.0 147.0 146.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:42:58 INFO - PROCESS | 16641 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.58 02:42:58 INFO - PROCESS | 16641 | Values: 57.0 54.0 58.0 55.0 58.0 55.0 57.0 55.0 55.0 54.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 02:42:58 INFO - PROCESS | 16641 | Values: 62.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 63.0 63.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:82.00 stddev:12.18 (14.8%) stddev-sans-first:12.90 02:42:58 INFO - PROCESS | 16641 | Values: 84.0 80.0 85.0 80.0 81.0 82.0 83.0 80.0 120.0 82.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.00 stddev:6.50 (5.1%) stddev-sans-first:5.54 02:42:58 INFO - PROCESS | 16641 | Values: 138.0 122.0 123.0 129.0 119.0 134.0 119.0 133.0 127.0 126.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:2.72 (1.7%) stddev-sans-first:2.57 02:42:58 INFO - PROCESS | 16641 | Values: 166.0 161.0 163.0 167.0 160.0 160.0 165.0 160.0 163.0 160.0 02:42:58 INFO - PROCESS | 16641 | 02:42:58 INFO - PROCESS | 16641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.33 (2.1%) stddev-sans-first:1.20 02:42:58 INFO - PROCESS | 16641 | Values: 65.0 63.0 65.0 62.0 63.0 62.0 62.0 63.0 64.0 61.0 02:42:58 INFO - PROCESS | 16641 | -------- Summary: end -------- 02:42:58 INFO - PROCESS | 16641 | 02:42:59 INFO - TEST-INFO | 16641: exit 0 02:42:59 INFO - TEST-OK | kraken | took 62261ms 02:42:59 INFO - SUITE-END | took 1173s 02:43:00 INFO - Completed test suite (00:19:33) 02:43:00 INFO - javascript benchmark 02:43:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7078.123735940134, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.372125574885, 3193.8722451101958, 3198.056573310873, 3230.3700778348216, 3232.660570640083, 5346.09116450203, 5521.585881058922, 5537.833864984052, 5559.388467268607, 5638.267025286717, 5387.488188622085, 5456.345238571367, 5483.698396588186, 5498.80754173604, 5565.6104072714925, 4929.334539837112, 4950.455449900508, 5038.294638750578, 5087.51668591485, 5133.537981581657, 735.832809297487, 5066.721330326831, 5076.543111119999, 5089.7964081436885, 5122.078025955327, 5056.26684130799, 5057.595392368602, 5061.0, 5062.569681577052, 5087.898242035176, 5003.524665156804, 5083.212102124176, 5091.516305950929, 5109.259157422153, 5111.565516931066, 5007.874803129915, 5030.949690503085, 5048.7223202723835, 5048.7980480780725, 5101.846944591668, 5341.545968592674, 5470.17947307903, 5491.341039075297, 5506.366767821672, 5525.364583072917, 5805.013147764848, 5885.293764748258, 5908.527317814564, 5966.194563733884, 5983.670898100603, 6010.459058684739, 6022.6687532185715, 6032.306284777219, 6034.155218269402, 6096.634201947897, 5602.0, 5604.691741954191, 5607.299087614089, 5611.2144299798065, 5630.915536266959, 5957.702114894238, 6027.397260274025, 6044.24446944132, 6074.939250607437, 6152.446279834837, 5835.4748072673665, 5840.415958404125, 5849.268841394825, 5851.590388672837, 5864.648121112747, 5875.11873219012, 5896.823095307148, 5944.464998150187, 5962.4633782959745, 5962.522998160223, 5779.855503612359, 5855.648661080349, 5890.14592884038, 5914.0, 5923.851903702442, 5713.914291285634, 5900.085486749561, 5926.288845338587, 5928.051511758098, 5936.881262374728, 4509.368688383629, 4512.413386259831, 4526.117407105583, 4539.182947069493, 4572.977135114304, 3938.7636741795586, 3941.231459865299, 3947.388154836005, 3975.5030621172355, 4014.337634290368, 5594.1888426177975, 5627.268455100811, 5649.265595472562, 5655.123455864347, 5661.773529058792, 5896.321922978912, 5988.670623115683, 5994.430529099728, 5994.550408719277, 6001.339852616209, 5563.610547261653, 5660.0, 5661.49046585801, 5669.036263835158, 5694.60137790359, 5121.641485096007, 5134.614903882224, 5175.378954525481, 5188.143956247252, 5208.947910520922, 6015.819525414245, 6253.1245625612455, 6257.0, 6258.217722784652, 6283.497320214372, 5873.706314684334, 5926.4666180044005, 5960.165576819336, 5962.433568810956, 5981.551383646331, 6082.422169893853, 6088.238970128734, 6115.0, 6126.877462450815, 6170.259568851767, 5735.799247026334, 5829.183914252093, 5839.270091238595, 5840.445157710011, 5895.4399332063385, 5977.970110149421, 6002.699865006645, 6065.787697430569, 6075.939240607538, 6125.938740612537, 5771.394003629558, 5851.151583020353, 5858.94141058584, 5883.441073098049, 5919.881602368015, 5650.29371328584, 5763.7982670606325, 5821.09772985188, 5889.175515427758, 5900.557458190567, 5582.916256256241, 5638.351589567253, 5651.915221271602, 5701.971490142523, 5777.2200752897825, 5878.059510478303, 5890.941090589039, 5892.852678683067, 5904.3800400959, 5930.584859059997, 5595.720213989202, 5645.322561292671, 5654.3497497788285, 5777.566682498746, 5781.132830075522], "value": 5443.555817386991, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.6386076771633, 602.9710025763308, 608.5223099866604, 621.5680102328881, 629.427221228682, 41909.37135942959, 43211.135777284435, 43211.91970200743, 43392.566074339244, 46726.29910551345, 43602.12795744083, 44075.77962110193, 44336.113277734425, 44343.0, 44388.77805610975, 8664.0902705216, 8744.081871403507, 8750.34372422071, 8805.075467075962, 8844.646214151426, 8638.611262493172, 8698.347623928199, 8725.912740872605, 8746.956265218665, 8749.47503149813, 8807.73576792694, 8840.823183536326, 8845.73462796114, 8859.778505537348, 8866.069062748415, 8660.956695216515, 8671.479711217347, 8714.085021072822, 8718.258947989396, 8746.912530874673, 8684.305255579602, 8696.869546956801, 8727.738167854974, 8774.605142768527, 8782.209601135864, 39885.20229595392, 40258.79870600658, 40467.0, 40474.1905161898, 40475.797621012, 3086.2901532647393, 3206.2144774530157, 3352.6479719629574, 3642.7450078494517, 3922.293987082324, 29371.265718356997, 31404.0, 31442.685573144205, 31789.04632861018, 32830.83584582086, 4344.740734817909, 4349.391085248068, 4410.162069206873, 4453.131639330332, 4515.909681806345, 357859.58193553577, 358132.0, 359979.0, 360840.0, 362221.0, 34264.65735342664, 60844.695776520835, 61172.69413652903, 61183.38816611866, 61186.38813611807, 35072.89562626251, 36906.8154659225, 37073.443898341546, 37081.25837483235, 37101.814490927914, 14685.265736713121, 14816.259187040605, 14899.404023838924, 14909.70180596382, 14938.850611493746, 12176.330301833306, 12311.56909508163, 12375.75248495043, 12413.069019823368, 12416.875831241572, 8190.631421586043, 8252.546109963889, 8268.462549934235, 8317.126701696356, 8342.332613390914, 3178.952315715266, 3204.6154461464776, 3214.6463888972194, 3224.2100685331775, 3255.511673248984, 965.5027660754716, 1042.6663467690266, 1089.145021158387, 1101.3612104979093, 1219.7316590350285, 30608.23479412988, 31446.37107257842, 31543.84228078845, 31559.52660710091, 31671.36657266842, 1107.6012635451232, 1132.9830052549053, 1133.7165708572857, 1141.57191053355, 1159.5245949160803, 16314.592135196715, 16956.406525771785, 16961.0, 17066.829331706773, 17264.568385790204, 555406.0, 556409.0, 560251.0, 564544.4182232665, 565382.0, 59532.70233648804, 59583.0, 60244.69877650672, 60646.0, 60687.0, 1351.7499262636443, 1389.8540653231466, 1396.3437184523257, 1401.278341654049, 1409.2249262905361, 28080.578791317737, 29193.562096568145, 29566.408671826874, 29572.408551828412, 29585.26036849096, 47243.52756472391, 48127.03745925132, 48135.0, 48185.5181448181, 48220.7588962053, 484203.0, 497141.0, 497381.0, 499050.0, 501200.0, 27827.860860695568, 27969.44061118807, 28109.57835632508, 28122.71877281283, 28151.859240704485, 47639.52360476351, 47650.6174691271, 48658.0, 49666.50333496619, 49755.0, 41466.0, 41688.79155604202, 41820.76530967062, 42293.0, 42539.0, 38112.809435952644, 38453.80773096117, 39012.609873900896, 39182.6081739179, 39743.403848942864, 34634.48048279227, 38499.80750096231, 38626.80686596549, 40711.59288407078, 41621.583784162984, 35925.82037089798, 36844.447333289485, 37292.0, 37323.626763733104, 37821.0, 28186.167899086493, 28281.292967675974, 29547.704522954496, 29679.40641187121, 30025.54961675533], "value": 18855.280271252574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2938710321421, 396.1403753854136, 401.1595706993847, 402.84289127240373, 416.254903722337, 18194.36319728808, 19427.611447771036, 19569.608607827835, 19600.509987250327, 20477.38567842967, 18374.72437913429, 19101.426957191306, 19372.031398430092, 19386.127624256907, 19461.902690486528, 5186.740662966856, 5205.3233079699585, 5740.483356497914, 5789.305283365981, 5832.445917637818, 5711.685857277848, 5718.399568045358, 5721.742521586518, 5728.083506638938, 5732.742026608792, 5432.619716619838, 5722.7424765885635, 5723.141528770697, 5723.5421166306805, 5729.140628905656, 5531.9723401382735, 5657.575681823859, 5699.943000569982, 5715.971125197463, 5722.856928576777, 5153.149730294497, 5161.845144645667, 5197.610179236573, 5202.635815492917, 5203.531682148587, 13834.23911684857, 13865.584032479042, 13912.58262252134, 17518.562035949075, 22516.549669006527, 2192.6601376786625, 2250.81993440526, 2320.454693147109, 2376.584097782881, 2650.2976711171555, 9946.602135914554, 10214.387136771817, 10256.641017564349, 10350.120239779628, 10568.788624227549, 1895.658781419344, 1937.980620193794, 1944.3486432045281, 1980.198019801968, 2000.57987822556, 83569.0, 85707.5714621429, 86170.56914715386, 87025.0, 88780.0, 10325.63860264887, 10767.19246056549, 10793.892061079447, 10815.729606759895, 10948.124150067975, 14733.0, 14761.77857332141, 14834.258287085819, 14904.329305181293, 14921.477748278976, 7464.925350746532, 7741.380689544823, 7842.686292548348, 7939.126696063428, 7993.720219792395, 7406.481546291708, 7491.8501629967095, 7611.1627720950655, 7612.010438642941, 7640.312371886445, 4419.42547468827, 4566.360709500673, 4740.336352910595, 4745.169595320874, 4774.976125119352, 1968.3701215611154, 1981.2669312354521, 2010.2361102780849, 2050.4668786115417, 2062.7318448601586, 900.0, 961.5480724059681, 989.8366769482955, 1010.2473657125488, 1051.0488008352454, 16968.490945271416, 18980.0, 19195.424137275902, 19411.0, 19625.0, 926.9814603708023, 946.9715908522755, 967.6791180039196, 1009.65671671632, 1012.5747186181821, 10562.20783441245, 10811.729706757236, 10832.458377081115, 10848.72878178036, 10875.401852898167, 477325.0, 477426.0, 483229.0, 494171.0, 497014.0, 68079.65960170167, 84670.0, 87199.0, 96806.0, 100338.49830750945, 1000.7147962830704, 1005.788784355279, 1014.9594016239415, 1032.6282538286212, 1033.720895358264, 17219.7417038747, 17503.562410939827, 17517.299308028047, 17564.736528952333, 17812.376566820098, 30062.849685752306, 43307.56692433036, 43462.26150953926, 44140.0, 44252.557474424844, 55072.72463637656, 55802.44197557973, 60638.39361606327, 60769.0, 61652.0, 7090.893636595352, 8422.410431269753, 8487.915120848713, 8642.913570864463, 8914.153155450222, 12810.935945320214, 13327.66680832987, 13539.052266341261, 13544.86455135436, 13584.796228056784, 11797.88202117968, 11965.820512692142, 12043.75912481728, 12065.939670301592, 12149.939250303692, 11291.604793832177, 11850.525978960744, 11858.110641701734, 11917.761644766882, 12012.099092568267, 12049.33728644933, 12097.274163550215, 12129.0, 12260.486600247106, 12351.505939762308, 8502.574871256289, 8547.0, 8550.401471896908, 8713.477191368538, 8756.299496040174, 11613.187076904873, 12633.178843375152, 12652.0, 12661.240325580495, 12818.871811281768], "value": 9102.692931004958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.5673626280243, 1512.7125846089245, 1625.2442614184401, 1729.1527151695673, 1755.1136675978628, 8101.959490202556, 8824.249938755205, 8872.58038713806, 9411.10594493522, 9413.29400294978, 8839.602217900194, 9105.27157827374, 9183.265338772899, 9207.401518901266, 9263.490508022072, 2315.5716192504397, 2317.640765681322, 2349.3304408243566, 2351.8471299365574, 2363.231949616373, 2292.3925159832656, 2312.606856834342, 2345.413646588353, 2359.551685179819, 2362.2676970139228, 2220.2562141682556, 2228.1533017453426, 2232.5311684546264, 2232.799048085672, 2247.741509726386, 2169.804717575426, 2188.9562208755897, 2202.8898555072265, 2205.228170140454, 2206.7682893296214, 2164.0, 2177.803997640204, 2182.5416662500734, 2240.529488807352, 2277.738060123074, 9088.818223635557, 9094.499802510925, 9116.954415227949, 9138.817223655557, 9189.356745027852, 5139.460356662534, 5240.68555886648, 5245.79016839326, 5246.055709972242, 5258.55302299305, 3223.5487031815564, 3377.5946886373545, 3468.2023134679166, 3517.613062563116, 3531.4526248431534, 1069.1927594666056, 1069.8983596558314, 1070.5824728355947, 1072.254782925867, 1083.5178345636195, 12954.48182072716, 12969.610911672571, 12971.0, 13083.803742943768, 13179.0, 4568.360429539867, 4600.769961501912, 4693.601043911306, 4709.034647897173, 4713.363695901009, 10956.726081847859, 11017.11863050954, 11033.558657653604, 11070.0, 11080.833787493195, 5231.424543300234, 5307.6019298552765, 5314.22943673173, 5316.043112239834, 5322.0, 4330.913381732347, 4713.622910167179, 4824.445188803263, 4885.193942999436, 4907.09218794517, 4099.487564054493, 4138.2894204296235, 4150.252954468165, 4159.313713237282, 4215.325547912319, 1233.5004323249098, 1284.9678758031123, 1290.7741145299535, 1298.701298701304, 1298.8571257161705, 913.3789023464108, 922.9630814767335, 923.3398120343986, 932.5477143585356, 960.9951950240344, 5809.912851307234, 5854.443827836349, 5922.526197904243, 5995.160677505153, 6046.123312119718, 408.47306974003203, 414.5812729143587, 416.4897999950098, 422.10303105899965, 423.8241129931106, 3971.841126354971, 3988.3818008208773, 4008.218397412535, 4051.8987025324604, 4120.093579412524, 11206.775864482664, 11468.13988950832, 11549.88450115505, 11597.594084207012, 11707.531698732126, 11523.250988685708, 11544.653660390202, 11613.59352422678, 11618.360990145455, 11651.126165537618, 8201.22088401601, 8646.697365592174, 8668.089850565726, 8718.520481373458, 8720.040795512488, 5592.105263157875, 5634.267545219095, 5734.54123670097, 5775.422457754191, 5782.959067367914, 10690.62582809598, 10716.892831071902, 10780.946095269474, 10810.891891080988, 10877.021068103908, 10589.258751887293, 10778.730531736455, 10954.616588419367, 10971.615993440191, 11099.72250693739, 7328.083989501312, 7666.769996900102, 7866.488678235896, 8029.357651387758, 8089.271965523131, 8868.11318868108, 8892.0, 8899.822003559762, 8907.910920890708, 8920.0, 7797.922020779946, 7835.216478352119, 7996.800079998046, 8029.518228906284, 8113.432059755761, 7863.724769633264, 8001.8399632008195, 8011.43919925623, 8120.593970301343, 8121.75634730959, 6660.56706314088, 6691.76578819739, 6718.966405167943, 6763.425108865801, 6765.086713293839, 4769.284607308931, 4796.376471058879, 4852.611791056777, 4862.440819305825, 4919.704817710949, 4722.834700785456, 4752.097101550694, 4774.307725379731, 4821.879453013703, 4837.782299796448], "value": 4575.667265284694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.95772591837147, 304.41704136578454, 305.2095073758964, 317.4745795708103, 320.92297848516347, 5569.721513924303, 5575.191597218401, 5579.69311687857, 5594.608377413578, 5602.691851948146, 5495.450454954503, 5502.697351645658, 5512.6968016759065, 5520.6687598744, 5527.723613819313, 4053.310937140693, 4155.940235240025, 4259.744415335074, 4266.893327666802, 4270.210011147932, 4244.662931176685, 4249.150169966004, 4251.385397980251, 4251.8511852085185, 4284.378765079062, 4211.284081706117, 4215.262329092412, 4215.831366745342, 4229.703920725535, 4238.830446782125, 3978.0, 4215.852445164404, 4217.8312867485265, 4219.767912764797, 4219.810108545123, 3614.36748569002, 3674.5590529136675, 3679.1721862580707, 3714.572824125233, 3715.7584756990977, 5335.81231695007, 5386.48828361305, 5390.73046347685, 5426.457354264581, 5429.8325859939905, 4596.287575425815, 4874.683145595525, 4887.993883761496, 4898.779554920002, 4940.851774446773, 5749.82750517481, 5773.134029895549, 5773.624714393551, 5798.9130163047585, 5800.477956983849, 4101.712880098395, 4118.670506359514, 4119.732217405859, 4121.876343709693, 4128.277551428518, 5831.31407731147, 6037.818865434, 6055.878882422327, 6081.361457046991, 6140.171076904606, 4153.605407486284, 4169.1661667665985, 4179.540250572434, 4181.121964387452, 4184.581541845852, 4176.081262122329, 4235.682323825726, 4238.427812245307, 4259.701820872509, 4273.0, 4726.172919739032, 4801.255805350176, 4820.975895120502, 4919.425783749238, 4947.985662939089, 5803.332616749043, 5834.941650583524, 5857.560682948796, 5858.531317494675, 5878.764849406061, 1443.5741456270425, 1452.0996981871097, 1455.9272036398138, 1461.1379286221181, 1473.4769156949344, 924.2375040591539, 936.3679516326453, 955.2071780422233, 957.4446820843893, 991.7173605522391, 5507.0, 5522.723863806794, 5593.888122237532, 5597.692126932976, 5609.467100625434, 5878.382769809194, 5911.9113213301835, 5942.732577034044, 5949.613275137102, 5952.940470595238, 5338.745394832211, 5570.220169176318, 5571.526420254243, 5602.299712535933, 5602.943970560324, 3170.952435713466, 3178.094243140694, 3194.632617249, 3196.3447493263825, 3198.2324242181708, 5955.34491205967, 6154.723037463235, 6162.7226774795245, 6164.137020817089, 6171.47542458896, 5956.821295361146, 6024.855277497261, 6027.517798576104, 6039.849003774941, 6041.305249896318, 6034.24571928509, 6072.453479186983, 6094.421030002142, 6120.418560236771, 6135.723892424851, 5634.774609015593, 5857.0, 5880.588358815013, 5920.851978700567, 5937.3468918418075, 5852.824415267549, 5910.349861515144, 5912.852178695395, 5912.911306330495, 5918.674472903859, 6056.06131049688, 6151.415615516519, 6166.660833654192, 6188.752449901954, 6218.968905155445, 4159.708820382544, 4175.227582897173, 4180.853670121531, 4182.728122672017, 4183.748975061506, 5956.195913551615, 5959.433853783884, 5973.283206015306, 5980.581359304981, 5997.850053748692, 5546.833594992157, 5722.284714410699, 5803.216565763737, 5805.796797112081, 5831.970840145772, 5747.770089196552, 5793.884122317614, 5820.73806678692, 5829.854253643693, 5848.298204215522, 5433.701146436984, 5469.808556700496, 5646.2942132233475, 5658.962773401655, 5671.262735844314, 5792.160136780228, 5794.304683438015, 5866.384029676993, 5888.735006924784, 5910.674912879833, 5558.0, 5692.31692196939, 5741.74162162712, 5778.479936805707, 5822.5633077518505], "value": 4380.538814292334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.5305169010917, 789.0, 793.6706266899237, 800.1318569352248, 811.1077814404156, 14225.857741422582, 14684.898632602557, 14887.404503819862, 14933.104013759183, 14971.101733895961, 13033.478660853554, 13602.115862468932, 13763.38064787087, 13807.585772426843, 13860.099093558913, 800.5997001499236, 809.2029351089172, 810.8864758933724, 811.6875003123811, 816.9468984516017, 810.5217921426357, 813.9755807325789, 814.2142832166958, 814.3973459639853, 815.5106935838479, 858.7853036740814, 859.7850537365658, 861.3281640320529, 861.9569021548898, 862.8533149364623, 858.7037472072125, 859.1408591408591, 860.2214995429147, 861.2076889261831, 863.0247819963464, 630.2059405149499, 630.6720505337245, 631.5263552335748, 631.6052467207995, 632.2413104274842, 13049.804252936214, 13091.803622945663, 13111.2133272004, 13113.409896554582, 13171.209727416386, 11735.520755654983, 11787.115966302561, 11788.705282367924, 11945.581904633296, 12032.51869925202, 10143.239257055677, 10187.47368681742, 10210.0, 10310.381377117323, 10331.58673653053, 3607.3326434609417, 3672.375696131664, 3676.0809797550614, 3706.0734816295926, 3749.062734316421, 54558.727206364114, 54949.0, 55139.0, 55487.72256138734, 59550.40449595492, 8985.685501007434, 9050.954745226363, 9071.27429805614, 9140.177384035336, 9222.170004699476, 17401.738973915402, 17645.558861028578, 17663.91168044177, 17741.556461088578, 17903.910480447776, 7708.267714567107, 7859.0, 7947.5231486111015, 7964.283214510722, 8028.237317454832, 4315.6763242756915, 4338.60952514269, 4410.911781764411, 4433.955660443419, 4439.844605438794, 3129.7339726123078, 3131.4989601663624, 3246.62663793662, 3247.821369824635, 3259.152620318734, 593.1695626123461, 628.1551313483358, 639.7057353617295, 642.0369445831253, 655.6459511863636, 592.4549414538635, 628.9748410063638, 631.4474834519796, 670.191895955943, 702.9543079699803, 9614.18279446241, 9778.559964801601, 9813.558389872473, 9854.901450985542, 9889.456079915673, 572.6964708704394, 652.6214795418646, 684.3669605614787, 723.5007844587218, 760.1030783675316, 4400.405945197422, 4554.544545545419, 4611.100835337077, 4642.2340313847835, 4748.928766068511, 78264.0, 78304.60847695725, 80121.0, 80876.59561702154, 81004.59497702592, 46430.76784616123, 54817.17774233389, 60202.397976020555, 67542.0, 71099.0, 55411.0, 56118.438815612135, 56826.14760778592, 57562.136567951515, 57830.13254801181, 9347.065293470598, 9527.57125929321, 9609.711708648752, 9632.47021413829, 9704.0, 35506.0, 35783.0, 36349.818250908575, 36670.8166459166, 37002.074948126516, 43551.78224108859, 46115.76942115402, 47225.7638711818, 49183.262251066975, 50241.748791255806, 12109.687253300344, 12129.636110916686, 12147.0, 12445.0, 12485.75028499443, 13258.53595124166, 13374.13068150567, 13924.695216319047, 13926.721465570834, 14369.425222990963, 12182.451789669309, 12560.623181304576, 12625.0, 13075.411606477921, 13092.738145237232, 13178.143420677625, 13423.865761342262, 13441.260730659907, 13541.864581354454, 14207.715845683235, 12387.706387488428, 12616.432260548114, 13004.869951300367, 13185.802212967004, 13370.0, 9250.537473126182, 9311.627534898527, 9527.28545359087, 9759.512024398893, 10430.11344035735, 9830.705078847646, 10351.741206469596, 10356.585736570754, 10564.471776410996, 10770.892291076989], "value": 6714.2925632755605, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0, 111.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 156.0, 179.0, 128.0, 159.0, 160.0, 128.0, 191.0, 128.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 161.0, 162.0, 163.0, 170.0, 160.0, 162.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 157.0, 76.0, 84.0, 75.0, 75.0, 162.0, 77.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 147.0, 83.0, 83.0, 84.0, 148.0, 84.0, 83.0, 140.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 151.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 58.0, 55.0, 58.0, 55.0, 57.0, 55.0, 55.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 85.0, 80.0, 81.0, 82.0, 83.0, 80.0, 120.0, 82.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 122.0, 123.0, 129.0, 119.0, 134.0, 119.0, 133.0, 127.0, 126.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 163.0, 167.0, 160.0, 160.0, 165.0, 160.0, 163.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 62.0, 63.0, 62.0, 62.0, 63.0, 64.0, 61.0], "value": 63.0, "unit": "score"}]}]} 02:43:00 INFO - Return code: 0 02:43:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:43:00 ERROR - # TBPL SUCCESS # 02:43:00 INFO - Running post-action listener: _resource_record_post_action 02:43:00 INFO - ##### 02:43:00 INFO - ##### Finished run-tests step (success) 02:43:00 INFO - ##### 02:43:00 INFO - Running post-run listener: _resource_record_post_run 02:43:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539664384; Read time: 16; Write time: 549280 02:43:00 INFO - TinderboxPrint: CPU usage
13.4% 02:43:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 02:43:00 INFO - TinderboxPrint: I/O write bytes / time
539,664,384 / 549,280 02:43:00 INFO - TinderboxPrint: CPU idle
8,225.2 (86.6%) 02:43:00 INFO - TinderboxPrint: CPU user
1,221.3 (12.9%) 02:43:00 INFO - TinderboxPrint: Swap in / out
0 / 0 02:43:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247304192; Read time: 0; Write time: 231404 02:43:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289689600; Read time: 16; Write time: 317740 02:43:00 INFO - Running post-run listener: _upload_blobber_files 02:43:00 INFO - Blob upload gear active. 02:43:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:43:00 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 02:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:43:01 INFO - (blobuploader) - INFO - Open directory for files ... 02:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:43:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:02 INFO - (blobuploader) - INFO - Done attempting. 02:43:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:43:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:03 INFO - (blobuploader) - INFO - Done attempting. 02:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:07 INFO - (blobuploader) - INFO - Done attempting. 02:43:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:07 INFO - Return code: 0 02:43:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc7117a3928b31f4ad885f71e37187866faa7b732fd4a64649d5319292411c9f28afc7e95f0d8fc80d4f10504b5b9cb1baa2eca5eb27838f43742b11a781b026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9709d98ba567516e64e21b4b11edf8efeabcc9e743809a174f65ac0292719cc6afbc6e4c8d9127859f6a8b93521e4359cd9f9e40acbce2cff8392c0acb26ded3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c4d5c9d72bdf3077ef957b3773b1e22d3db3e4745212b20cf2dd32350e68ab722c9a0aeec9afb1977307e57a53a1b0912bf02ae598826d9662c9cbe84941840"} 02:43:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:07 INFO - Contents: 02:43:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc7117a3928b31f4ad885f71e37187866faa7b732fd4a64649d5319292411c9f28afc7e95f0d8fc80d4f10504b5b9cb1baa2eca5eb27838f43742b11a781b026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9709d98ba567516e64e21b4b11edf8efeabcc9e743809a174f65ac0292719cc6afbc6e4c8d9127859f6a8b93521e4359cd9f9e40acbce2cff8392c0acb26ded3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c4d5c9d72bdf3077ef957b3773b1e22d3db3e4745212b20cf2dd32350e68ab722c9a0aeec9afb1977307e57a53a1b0912bf02ae598826d9662c9cbe84941840"} 02:43:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:07 INFO - Copying logs to upload dir... 02:43:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.768058 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-31 02:43:07.855055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 02:43:07.858824) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc7117a3928b31f4ad885f71e37187866faa7b732fd4a64649d5319292411c9f28afc7e95f0d8fc80d4f10504b5b9cb1baa2eca5eb27838f43742b11a781b026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9709d98ba567516e64e21b4b11edf8efeabcc9e743809a174f65ac0292719cc6afbc6e4c8d9127859f6a8b93521e4359cd9f9e40acbce2cff8392c0acb26ded3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c4d5c9d72bdf3077ef957b3773b1e22d3db3e4745212b20cf2dd32350e68ab722c9a0aeec9afb1977307e57a53a1b0912bf02ae598826d9662c9cbe84941840"} build_url:https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/FpFYbRizSsa-WV5sxqxvng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc7117a3928b31f4ad885f71e37187866faa7b732fd4a64649d5319292411c9f28afc7e95f0d8fc80d4f10504b5b9cb1baa2eca5eb27838f43742b11a781b026", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9709d98ba567516e64e21b4b11edf8efeabcc9e743809a174f65ac0292719cc6afbc6e4c8d9127859f6a8b93521e4359cd9f9e40acbce2cff8392c0acb26ded3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c4d5c9d72bdf3077ef957b3773b1e22d3db3e4745212b20cf2dd32350e68ab722c9a0aeec9afb1977307e57a53a1b0912bf02ae598826d9662c9cbe84941840"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 02:43:07.886727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:43:07.887242) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464683608.569677-504283578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 02:43:07.970590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 02:43:07.970908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 02:43:07.971244) ========= ========= Total master_lag: 0.18 =========