builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1463088184.22 results: success (0) buildid: 20160512113001 builduid: 83a8539f475d4d4483a6cd25c46ebd36 revision: a97eec37ec2d4ded719ad996d75c431b7043fa5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.218142) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.218579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.218862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.251484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.251762) ========= 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=00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-12 14:23:04-- 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% 424M=0s 2016-05-12 14:23:04 (424 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104630 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.651641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.651934) ========= 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=00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009601 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.671507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:04.671855) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a97eec37ec2d4ded719ad996d75c431b7043fa5a --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 a97eec37ec2d4ded719ad996d75c431b7043fa5a --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=00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-12 14:23:04,709 truncating revision to first 12 chars 2016-05-12 14:23:04,709 Setting DEBUG logging. 2016-05-12 14:23:04,709 attempt 1/10 2016-05-12 14:23:04,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a97eec37ec2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-12 14:23:05,023 unpacking tar archive at: fx-team-a97eec37ec2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:05.251237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:05.254591) ========= script_repo_revision: a97eec37ec2d4ded719ad996d75c431b7043fa5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:05.254987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:05.255261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-12 14:23:05.264670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-12 14:23:05.265057) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:23:05 INFO - MultiFileLogger online at 20160512 14:23:05 in /builds/slave/test 14:23:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:23:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:05 INFO - {'append_to_log': False, 14:23:05 INFO - 'base_work_dir': '/builds/slave/test', 14:23:05 INFO - 'blob_upload_branch': 'Fx-Team', 14:23:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:05 INFO - 'branch': 'Fx-Team', 14:23:05 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:05 INFO - 'config_files': ('talos/linux_config.py',), 14:23:05 INFO - 'default_actions': ('clobber', 14:23:05 INFO - 'read-buildbot-config', 14:23:05 INFO - 'download-and-extract', 14:23:05 INFO - 'populate-webroot', 14:23:05 INFO - 'create-virtualenv', 14:23:05 INFO - 'install', 14:23:05 INFO - 'run-tests'), 14:23:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:05 INFO - 'download_minidump_stackwalk': True, 14:23:05 INFO - 'download_symbols': 'ondemand', 14:23:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:05 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:05 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:05 INFO - 'installer_path': 'installer.exe', 14:23:05 INFO - 'log_level': 'info', 14:23:05 INFO - 'log_name': 'talos', 14:23:05 INFO - 'log_to_console': True, 14:23:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:23:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:23:05 INFO - 'opt_config_files': (), 14:23:05 INFO - 'pip_index': False, 14:23:05 INFO - 'sps_profile': False, 14:23:05 INFO - 'sps_profile_interval': 0, 14:23:05 INFO - 'suite': 'dromaeojs', 14:23:05 INFO - 'system_bits': '32', 14:23:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:05 INFO - 'title': 'talos-linux64-ix-016', 14:23:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:05 INFO - 'use_talos_json': True, 14:23:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:05 INFO - 'work_dir': 'build'} 14:23:05 INFO - ##### 14:23:05 INFO - ##### Running clobber step. 14:23:05 INFO - ##### 14:23:05 INFO - Running pre-action listener: _resource_record_pre_action 14:23:05 INFO - Running main action method: clobber 14:23:05 INFO - rmtree: /builds/slave/test/build 14:23:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:05 INFO - Running post-action listener: _resource_record_post_action 14:23:05 INFO - ##### 14:23:05 INFO - ##### Finished clobber step (success) 14:23:05 INFO - ##### 14:23:05 INFO - ##### 14:23:05 INFO - ##### Running read-buildbot-config step. 14:23:05 INFO - ##### 14:23:05 INFO - Running pre-action listener: _resource_record_pre_action 14:23:05 INFO - Running main action method: read_buildbot_config 14:23:05 INFO - Using buildbot properties: 14:23:05 INFO - { 14:23:05 INFO - "project": "", 14:23:05 INFO - "product": "firefox", 14:23:05 INFO - "script_repo_revision": "production", 14:23:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:23:05 INFO - "repository": "", 14:23:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:23:05 INFO - "buildid": "20160512113001", 14:23:05 INFO - "pgo_build": "True", 14:23:05 INFO - "basedir": "/builds/slave/test", 14:23:05 INFO - "buildnumber": 669, 14:23:05 INFO - "slavename": "talos-linux64-ix-016", 14:23:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:23:05 INFO - "platform": "ubuntu64_hw", 14:23:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:23:05 INFO - "branch": "fx-team", 14:23:05 INFO - "repo_path": "integration/fx-team", 14:23:05 INFO - "revision": "a97eec37ec2d4ded719ad996d75c431b7043fa5a", 14:23:05 INFO - "stage_platform": "linux64-pgo", 14:23:05 INFO - "builduid": "83a8539f475d4d4483a6cd25c46ebd36", 14:23:05 INFO - "slavebuilddir": "test" 14:23:05 INFO - } 14:23:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:23:05 INFO - Running post-action listener: _resource_record_post_action 14:23:05 INFO - ##### 14:23:05 INFO - ##### Finished read-buildbot-config step (success) 14:23:05 INFO - ##### 14:23:05 INFO - ##### 14:23:05 INFO - ##### Running download-and-extract step. 14:23:05 INFO - ##### 14:23:05 INFO - Running pre-action listener: _resource_record_pre_action 14:23:05 INFO - Running main action method: download_and_extract 14:23:05 INFO - mkdir: /builds/slave/test/build/tests 14: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')]} 14:23:05 INFO - https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:07 INFO - Downloaded 1361 bytes. 14:23:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:23:07 INFO - Using the following test package requirements: 14:23:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:23:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:23:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:23:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'jsshell-linux-x86_64.zip'], 14:23:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:23:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:23:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:23:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:23:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:23:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:23:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:23:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:23:07 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')]} 14:23:07 INFO - https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:08 INFO - Downloaded 23903086 bytes. 14:23:08 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'] 14:23:08 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 14:23:09 INFO - Return code: 0 14:23:09 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 14:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:09 INFO - https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:23:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:23:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:11 INFO - Downloaded 23903086 bytes. 14:23:11 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'] 14:23:11 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 14:23:13 INFO - Return code: 0 14:23:13 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')]} 14:23:13 INFO - https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:23:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:23:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:23:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:14 INFO - Downloaded 10840239 bytes. 14:23:14 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'] 14:23:14 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 14:23:14 INFO - Return code: 0 14:23:14 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')]} 14:23:14 INFO - https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:23:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/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 14:23:15 INFO - Downloaded 58347918 bytes. 14:23:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:15 INFO - mkdir: /builds/slave/test/properties 14:23:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:15 INFO - Contents: 14:23:15 INFO - build_url:https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:23:16 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2! 14:23:16 WARNING - No symbols_url found. Let minidump_stackwalk query for symbols. 14:23:16 INFO - Running post-action listener: _resource_record_post_action 14:23:16 INFO - Running post-action listener: set_extra_try_arguments 14:23:16 INFO - ##### 14:23:16 INFO - ##### Finished download-and-extract step (success) 14:23:16 INFO - ##### 14:23:16 INFO - ##### 14:23:16 INFO - ##### Running populate-webroot step. 14:23:16 INFO - ##### 14:23:16 INFO - Running pre-action listener: _resource_record_pre_action 14:23:16 INFO - Running main action method: populate_webroot 14:23:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:16 INFO - '--tppagecycles', 14:23:16 INFO - '7'], 14:23:16 INFO - 'tests': ['tsvgm']}}, 14:23:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['damp', 'tps']}, 14:23:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'tests': ['damp', 'tps']}, 14:23:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['dromaeo_dom']}, 14:23:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['a11yr', 14:23:16 INFO - 'ts_paint', 14:23:16 INFO - 'tpaint', 14:23:16 INFO - 'sessionrestore', 14:23:16 INFO - 'sessionrestore_no_auto_restore', 14:23:16 INFO - 'tabpaint']}, 14:23:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:16 INFO - 'ts_paint', 14:23:16 INFO - 'tpaint', 14:23:16 INFO - 'sessionrestore', 14:23:16 INFO - 'sessionrestore_no_auto_restore', 14:23:16 INFO - 'tabpaint']}, 14:23:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:16 INFO - 'ts_paint', 14:23:16 INFO - 'tpaint', 14:23:16 INFO - 'sessionrestore', 14:23:16 INFO - 'sessionrestore_no_auto_restore', 14:23:16 INFO - 'tabpaint']}, 14:23:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:16 INFO - 'ts_paint', 14:23:16 INFO - 'tpaint', 14:23:16 INFO - 'sessionrestore', 14:23:16 INFO - 'sessionrestore_no_auto_restore', 14:23:16 INFO - 'tabpaint']}, 14:23:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['a11yr', 14:23:16 INFO - 'ts_paint', 14:23:16 INFO - 'tpaint', 14:23:16 INFO - 'sessionrestore', 14:23:16 INFO - 'sessionrestore_no_auto_restore', 14:23:16 INFO - 'tabpaint']}, 14:23:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['a11yr', 14:23:16 INFO - 'ts_paint', 14:23:16 INFO - 'tpaint', 14:23:16 INFO - 'sessionrestore', 14:23:16 INFO - 'sessionrestore_no_auto_restore', 14:23:16 INFO - 'tabpaint']}, 14:23:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['tsvgx', 14:23:16 INFO - 'tsvgr_opacity', 14:23:16 INFO - 'tart', 14:23:16 INFO - 'tscrollx', 14:23:16 INFO - 'cart']}, 14:23:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:16 INFO - 'tsvgr_opacity', 14:23:16 INFO - 'tart', 14:23:16 INFO - 'tscrollx', 14:23:16 INFO - 'cart']}, 14:23:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'talos_options': ['--disable-e10s'], 14:23:16 INFO - 'tests': ['tp5o']}, 14:23:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'tests': ['tp5o']}, 14:23:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'talos_options': ['--disable-e10s', 14:23:16 INFO - '--xperf_path', 14:23:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:16 INFO - 'tests': ['tp5n']}, 14:23:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:16 INFO - 'talos_options': ['--xperf_path', 14:23:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:16 INFO - 'tests': ['tp5n']}}, 14:23:16 INFO - 'talos.zip': {'path': '', 14:23:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:16 INFO - Running post-action listener: _resource_record_post_action 14:23:16 INFO - ##### 14:23:16 INFO - ##### Finished populate-webroot step (success) 14:23:16 INFO - ##### 14:23:16 INFO - ##### 14:23:16 INFO - ##### Running create-virtualenv step. 14:23:16 INFO - ##### 14:23:16 INFO - Running pre-action listener: _resource_record_pre_action 14:23:16 INFO - Running main action method: create_virtualenv 14:23:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:16 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 14:23:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:16 INFO - Using real prefix '/usr' 14:23:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:18 INFO - Installing pip.................done. 14:23:18 INFO - Return code: 0 14:23:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:18 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 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:18 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 14:23:18 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 14:23:18 INFO - Using env: {'DISPLAY': ':0', 14:23:18 INFO - 'HOME': '/home/cltbld', 14:23:18 INFO - 'LANG': 'en_US.UTF-8', 14:23:18 INFO - 'LANGUAGE': 'en_US:en', 14:23:18 INFO - 'LOGNAME': 'cltbld', 14:23:18 INFO - 'MAIL': '/var/mail/cltbld', 14:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:18 INFO - 'MOZ_NO_REMOTE': '1', 14:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:18 INFO - 'NO_EM_RESTART': '1', 14:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:18 INFO - 'PWD': '/builds/slave/test', 14:23:18 INFO - 'SHELL': '/bin/bash', 14:23:18 INFO - 'SHLVL': '1', 14:23:18 INFO - 'TERM': 'linux', 14:23:18 INFO - 'TMOUT': '86400', 14:23:18 INFO - 'USER': 'cltbld', 14:23:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:18 INFO - '_': '/tools/buildbot/bin/python'} 14:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:19 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 14:23:19 INFO - Cleaning up... 14:23:19 INFO - Return code: 0 14:23:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:23:19 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')]} 14:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:19 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')]} 14:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:23:19 INFO - Using env: {'DISPLAY': ':0', 14:23:19 INFO - 'HOME': '/home/cltbld', 14:23:19 INFO - 'LANG': 'en_US.UTF-8', 14:23:19 INFO - 'LANGUAGE': 'en_US:en', 14:23:19 INFO - 'LOGNAME': 'cltbld', 14:23:19 INFO - 'MAIL': '/var/mail/cltbld', 14:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:19 INFO - 'MOZ_NO_REMOTE': '1', 14:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:19 INFO - 'NO_EM_RESTART': '1', 14:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:19 INFO - 'PWD': '/builds/slave/test', 14:23:19 INFO - 'SHELL': '/bin/bash', 14:23:19 INFO - 'SHLVL': '1', 14:23:19 INFO - 'TERM': 'linux', 14:23:19 INFO - 'TMOUT': '86400', 14:23:19 INFO - 'USER': 'cltbld', 14:23:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:19 INFO - '_': '/tools/buildbot/bin/python'} 14:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:19 INFO - Downloading/unpacking psutil>=0.7.1 14:23:19 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 14:23:19 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 14:23:19 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 14:23:19 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 14:23:19 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 14:23:19 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 14:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:21 INFO - Installing collected packages: psutil 14:23:21 INFO - Running setup.py install for psutil 14:23:21 INFO - building 'psutil._psutil_linux' extension 14:23:21 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 14:23:21 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 14:23:21 INFO - building 'psutil._psutil_posix' extension 14:23:21 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 14:23:21 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 14:23:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:21 INFO - Successfully installed psutil 14:23:21 INFO - Cleaning up... 14:23:21 INFO - Return code: 0 14:23:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:23:21 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')]} 14:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 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')]} 14:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:23:21 INFO - Using env: {'DISPLAY': ':0', 14:23:21 INFO - 'HOME': '/home/cltbld', 14:23:21 INFO - 'LANG': 'en_US.UTF-8', 14:23:21 INFO - 'LANGUAGE': 'en_US:en', 14:23:21 INFO - 'LOGNAME': 'cltbld', 14:23:21 INFO - 'MAIL': '/var/mail/cltbld', 14:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:21 INFO - 'MOZ_NO_REMOTE': '1', 14:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:21 INFO - 'NO_EM_RESTART': '1', 14:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:21 INFO - 'PWD': '/builds/slave/test', 14:23:21 INFO - 'SHELL': '/bin/bash', 14:23:21 INFO - 'SHLVL': '1', 14:23:21 INFO - 'TERM': 'linux', 14:23:21 INFO - 'TMOUT': '86400', 14:23:21 INFO - 'USER': 'cltbld', 14:23:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:21 INFO - '_': '/tools/buildbot/bin/python'} 14:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:23:21 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 14:23:21 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 14:23:21 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 14:23:21 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 14:23:21 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 14:23:21 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 14:23:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:23:23 INFO - Installing collected packages: mozsystemmonitor 14:23:23 INFO - Running setup.py install for mozsystemmonitor 14:23:23 INFO - Successfully installed mozsystemmonitor 14:23:23 INFO - Cleaning up... 14:23:23 INFO - Return code: 0 14:23:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:23 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')]} 14:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:23 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')]} 14:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:23 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 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:23 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 14:23:23 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 14:23:23 INFO - Using env: {'DISPLAY': ':0', 14:23:23 INFO - 'HOME': '/home/cltbld', 14:23:23 INFO - 'LANG': 'en_US.UTF-8', 14:23:23 INFO - 'LANGUAGE': 'en_US:en', 14:23:23 INFO - 'LOGNAME': 'cltbld', 14:23:23 INFO - 'MAIL': '/var/mail/cltbld', 14:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:23 INFO - 'MOZ_NO_REMOTE': '1', 14:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:23 INFO - 'NO_EM_RESTART': '1', 14:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:23 INFO - 'PWD': '/builds/slave/test', 14:23:23 INFO - 'SHELL': '/bin/bash', 14:23:23 INFO - 'SHLVL': '1', 14:23:23 INFO - 'TERM': 'linux', 14:23:23 INFO - 'TMOUT': '86400', 14:23:23 INFO - 'USER': 'cltbld', 14:23:23 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:23 INFO - '_': '/tools/buildbot/bin/python'} 14:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 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 14:23:26 INFO - Downloading docopt-0.6.1.tar.gz 14:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:26 INFO - Running setup.py install for blobuploader 14:23:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:26 INFO - Running setup.py install for requests 14:23:27 INFO - Running setup.py install for docopt 14:23:27 INFO - Successfully installed blobuploader requests docopt 14:23:27 INFO - Cleaning up... 14:23:27 INFO - Return code: 0 14:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:27 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 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:27 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 14:23:27 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 14:23:27 INFO - Using env: {'DISPLAY': ':0', 14:23:27 INFO - 'HOME': '/home/cltbld', 14:23:27 INFO - 'LANG': 'en_US.UTF-8', 14:23:27 INFO - 'LANGUAGE': 'en_US:en', 14:23:27 INFO - 'LOGNAME': 'cltbld', 14:23:27 INFO - 'MAIL': '/var/mail/cltbld', 14:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:27 INFO - 'MOZ_NO_REMOTE': '1', 14:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:27 INFO - 'NO_EM_RESTART': '1', 14:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:27 INFO - 'PWD': '/builds/slave/test', 14:23:27 INFO - 'SHELL': '/bin/bash', 14:23:27 INFO - 'SHLVL': '1', 14:23:27 INFO - 'TERM': 'linux', 14:23:27 INFO - 'TMOUT': '86400', 14:23:27 INFO - 'USER': 'cltbld', 14:23:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:27 INFO - '_': '/tools/buildbot/bin/python'} 14:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:27 INFO - Running setup.py (path:/tmp/pip-pdP_AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:27 INFO - Running setup.py (path:/tmp/pip-Tg_Pk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:27 INFO - Running setup.py (path:/tmp/pip-gZJUvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:27 INFO - Running setup.py (path:/tmp/pip-VUoWBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:27 INFO - Running setup.py (path:/tmp/pip-oLJYqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:27 INFO - Running setup.py (path:/tmp/pip-d7flBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:27 INFO - Running setup.py (path:/tmp/pip-8AdGz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:27 INFO - Running setup.py (path:/tmp/pip-zdbYDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:27 INFO - Running setup.py (path:/tmp/pip-iKqZy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:27 INFO - Running setup.py (path:/tmp/pip-XsAMf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:27 INFO - Running setup.py (path:/tmp/pip-HSQA2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:28 INFO - Running setup.py (path:/tmp/pip-cdww8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:28 INFO - Running setup.py (path:/tmp/pip-9zyJMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:28 INFO - Running setup.py (path:/tmp/pip-FPWqzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:28 INFO - Running setup.py (path:/tmp/pip-bw_IVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:28 INFO - Running setup.py (path:/tmp/pip-2JqDIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:28 INFO - Running setup.py (path:/tmp/pip-pRPFGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:28 INFO - Running setup.py install for manifestparser 14:23:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:28 INFO - Running setup.py install for mozcrash 14:23:28 INFO - Running setup.py install for mozdebug 14:23:28 INFO - Running setup.py install for mozdevice 14:23:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:28 INFO - Running setup.py install for mozfile 14:23:28 INFO - Running setup.py install for mozhttpd 14:23:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:28 INFO - Running setup.py install for mozinfo 14:23:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Running setup.py install for mozInstall 14:23:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Running setup.py install for mozleak 14:23:29 INFO - Running setup.py install for mozlog 14:23:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Running setup.py install for moznetwork 14:23:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Running setup.py install for mozprocess 14:23:29 INFO - Running setup.py install for mozprofile 14:23:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Running setup.py install for mozrunner 14:23:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Running setup.py install for mozscreenshot 14:23:29 INFO - Running setup.py install for moztest 14:23:29 INFO - Running setup.py install for mozversion 14:23:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:29 INFO - Cleaning up... 14:23:29 INFO - Return code: 0 14:23:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:29 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 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:29 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 14:23:29 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 14:23:29 INFO - Using env: {'DISPLAY': ':0', 14:23:29 INFO - 'HOME': '/home/cltbld', 14:23:29 INFO - 'LANG': 'en_US.UTF-8', 14:23:29 INFO - 'LANGUAGE': 'en_US:en', 14:23:29 INFO - 'LOGNAME': 'cltbld', 14:23:29 INFO - 'MAIL': '/var/mail/cltbld', 14:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:29 INFO - 'MOZ_NO_REMOTE': '1', 14:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:29 INFO - 'NO_EM_RESTART': '1', 14:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:29 INFO - 'PWD': '/builds/slave/test', 14:23:29 INFO - 'SHELL': '/bin/bash', 14:23:29 INFO - 'SHLVL': '1', 14:23:29 INFO - 'TERM': 'linux', 14:23:29 INFO - 'TMOUT': '86400', 14:23:29 INFO - 'USER': 'cltbld', 14:23:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:29 INFO - '_': '/tools/buildbot/bin/python'} 14:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:30 INFO - Running setup.py (path:/tmp/pip-6WvR6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:30 INFO - Running setup.py (path:/tmp/pip-8HNOzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:30 INFO - Running setup.py (path:/tmp/pip-UEu52e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:30 INFO - Running setup.py (path:/tmp/pip-WqqoQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:30 INFO - Running setup.py (path:/tmp/pip-PJ7Zvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:30 INFO - Running setup.py (path:/tmp/pip-PxioWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:30 INFO - Running setup.py (path:/tmp/pip-ox3QOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:30 INFO - Running setup.py (path:/tmp/pip-GLTIhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:30 INFO - Running setup.py (path:/tmp/pip-3w7g36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:30 INFO - Running setup.py (path:/tmp/pip-cBkNqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:30 INFO - Running setup.py (path:/tmp/pip-qNhuII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:30 INFO - Running setup.py (path:/tmp/pip-s9bIKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:30 INFO - Running setup.py (path:/tmp/pip-NXV_84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:30 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)) 14:23:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:30 INFO - Running setup.py (path:/tmp/pip-_yRgud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:31 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)) 14:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:31 INFO - Running setup.py (path:/tmp/pip-9I4zMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:31 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)) 14:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:31 INFO - Running setup.py (path:/tmp/pip-ri2NMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:31 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)) 14:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:31 INFO - Running setup.py (path:/tmp/pip-Mmlg67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:31 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)) 14:23:31 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)) 14:23:31 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)) 14:23:31 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)) 14:23:31 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)) 14:23:31 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)) 14:23:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:31 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 14:23:31 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 14:23:31 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 14:23:31 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 14:23:31 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 14:23:31 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 14:23:33 INFO - Downloading blessings-1.6.tar.gz 14:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:33 INFO - Installing collected packages: blessings 14:23:33 INFO - Running setup.py install for blessings 14:23:33 INFO - Successfully installed blessings 14:23:33 INFO - Cleaning up... 14:23:33 INFO - Return code: 0 14:23:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:33 INFO - Reading from file tmpfile_stdout 14:23:33 INFO - Current package versions: 14:23:33 INFO - argparse == 1.2.1 14:23:33 INFO - blessings == 1.6 14:23:33 INFO - blobuploader == 1.2.4 14:23:33 INFO - docopt == 0.6.1 14:23:33 INFO - manifestparser == 1.1 14:23:33 INFO - mozInstall == 1.12 14:23:33 INFO - mozcrash == 0.17 14:23:33 INFO - mozdebug == 0.1 14:23:33 INFO - mozdevice == 0.48 14:23:33 INFO - mozfile == 1.2 14:23:33 INFO - mozhttpd == 0.7 14:23:33 INFO - mozinfo == 0.9 14:23:33 INFO - mozleak == 0.1 14:23:33 INFO - mozlog == 3.2 14:23:33 INFO - moznetwork == 0.27 14:23:33 INFO - mozprocess == 0.22 14:23:33 INFO - mozprofile == 0.28 14:23:33 INFO - mozrunner == 6.11 14:23:33 INFO - mozscreenshot == 0.1 14:23:33 INFO - mozsystemmonitor == 0.0 14:23:33 INFO - moztest == 0.7 14:23:33 INFO - mozversion == 1.4 14:23:33 INFO - psutil == 3.1.1 14:23:33 INFO - requests == 1.2.3 14:23:33 INFO - wsgiref == 0.1.2 14:23:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:33 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')]} 14:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:33 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')]} 14:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:33 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 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:33 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 14:23:33 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 14:23:33 INFO - Using env: {'DISPLAY': ':0', 14:23:33 INFO - 'HOME': '/home/cltbld', 14:23:33 INFO - 'LANG': 'en_US.UTF-8', 14:23:33 INFO - 'LANGUAGE': 'en_US:en', 14:23:33 INFO - 'LOGNAME': 'cltbld', 14:23:33 INFO - 'MAIL': '/var/mail/cltbld', 14:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:33 INFO - 'MOZ_NO_REMOTE': '1', 14:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:33 INFO - 'NO_EM_RESTART': '1', 14:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:33 INFO - 'PWD': '/builds/slave/test', 14:23:33 INFO - 'SHELL': '/bin/bash', 14:23:33 INFO - 'SHLVL': '1', 14:23:33 INFO - 'TERM': 'linux', 14:23:33 INFO - 'TMOUT': '86400', 14:23:33 INFO - 'USER': 'cltbld', 14:23:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:33 INFO - '_': '/tools/buildbot/bin/python'} 14:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 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)) 14:23:33 INFO - Cleaning up... 14:23:33 INFO - Return code: 0 14:23:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:33 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')]} 14:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:33 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')]} 14:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:33 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 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:33 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 14:23:33 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 14:23:33 INFO - Using env: {'DISPLAY': ':0', 14:23:33 INFO - 'HOME': '/home/cltbld', 14:23:33 INFO - 'LANG': 'en_US.UTF-8', 14:23:33 INFO - 'LANGUAGE': 'en_US:en', 14:23:33 INFO - 'LOGNAME': 'cltbld', 14:23:33 INFO - 'MAIL': '/var/mail/cltbld', 14:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:33 INFO - 'MOZ_NO_REMOTE': '1', 14:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:33 INFO - 'NO_EM_RESTART': '1', 14:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:33 INFO - 'PWD': '/builds/slave/test', 14:23:33 INFO - 'SHELL': '/bin/bash', 14:23:33 INFO - 'SHLVL': '1', 14:23:33 INFO - 'TERM': 'linux', 14:23:33 INFO - 'TMOUT': '86400', 14:23:33 INFO - 'USER': 'cltbld', 14:23:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:33 INFO - '_': '/tools/buildbot/bin/python'} 14:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:33 INFO - Downloading/unpacking jsonschema 14:23:33 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 14:23:33 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 14:23:33 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 14:23:33 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 14:23:33 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 14:23:33 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 14:23:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:35 INFO - Downloading/unpacking functools32 (from jsonschema) 14:23:35 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 14:23:35 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 14:23:35 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 14:23:35 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 14:23:35 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 14:23:35 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 14:23:35 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:35 INFO - warning: no files found matching '*.txt' 14:23:35 INFO - no previously-included directories found matching 'build' 14:23:35 INFO - no previously-included directories found matching 'dist' 14:23:35 INFO - no previously-included directories found matching '.git*' 14:23:35 INFO - Installing collected packages: jsonschema, functools32 14:23:35 INFO - Running setup.py install for functools32 14:23:36 INFO - warning: no files found matching '*.txt' 14:23:36 INFO - no previously-included directories found matching 'build' 14:23:36 INFO - no previously-included directories found matching 'dist' 14:23:36 INFO - no previously-included directories found matching '.git*' 14:23:36 INFO - Successfully installed jsonschema functools32 14:23:36 INFO - Cleaning up... 14:23:36 INFO - Return code: 0 14:23:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:36 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 0x7f704b407f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, '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': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', '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 14:23:36 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 14:23:36 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 14:23:36 INFO - Using env: {'DISPLAY': ':0', 14:23:36 INFO - 'HOME': '/home/cltbld', 14:23:36 INFO - 'LANG': 'en_US.UTF-8', 14:23:36 INFO - 'LANGUAGE': 'en_US:en', 14:23:36 INFO - 'LOGNAME': 'cltbld', 14:23:36 INFO - 'MAIL': '/var/mail/cltbld', 14:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:36 INFO - 'MOZ_NO_REMOTE': '1', 14:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:36 INFO - 'NO_EM_RESTART': '1', 14:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:36 INFO - 'PWD': '/builds/slave/test', 14:23:36 INFO - 'SHELL': '/bin/bash', 14:23:36 INFO - 'SHLVL': '1', 14:23:36 INFO - 'TERM': 'linux', 14:23:36 INFO - 'TMOUT': '86400', 14:23:36 INFO - 'USER': 'cltbld', 14:23:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:36 INFO - '_': '/tools/buildbot/bin/python'} 14:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:36 INFO - Downloading/unpacking flake8 14:23:36 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 14:23:36 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 14:23:36 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 14:23:36 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 14:23:36 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 14:23:36 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 14:23:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:23:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:23:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 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 14:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:23:38 INFO - no previously-included directories found matching 'docs/_build' 14:23:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:23:38 INFO - Running setup.py install for pep8 14:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:23:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:23:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:23:38 INFO - no previously-included directories found matching 'docs/_build' 14:23:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:23:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:23:39 INFO - Cleaning up... 14:23:39 INFO - Return code: 0 14:23:39 INFO - Running post-action listener: _resource_record_post_action 14:23:39 INFO - Running post-action listener: _start_resource_monitoring 14:23:39 INFO - Starting resource monitoring. 14:23:39 INFO - ##### 14:23:39 INFO - ##### Finished create-virtualenv step (success) 14:23:39 INFO - ##### 14:23:39 INFO - ##### 14:23:39 INFO - ##### Running install step. 14:23:39 INFO - ##### 14:23:39 INFO - Running pre-action listener: _resource_record_pre_action 14:23:39 INFO - Running main action method: install 14:23:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:39 INFO - Reading from file tmpfile_stdout 14:23:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:39 INFO - Reading from file tmpfile_stdout 14:23:39 INFO - Output received: 14:23:39 INFO - Usage: mozinstall [options] installer 14:23:39 INFO - Options: 14:23:39 INFO - -h, --help show this help message and exit 14:23:39 INFO - -d DEST, --destination=DEST 14:23:39 INFO - Directory to install application into. [default: 14:23:39 INFO - "/builds/slave/test"] 14:23:39 INFO - --app=APP Application being installed. [default: firefox] 14:23:39 INFO - mkdir: /builds/slave/test/build/application 14:23:39 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'] 14:23:39 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 14:23:55 INFO - Reading from file tmpfile_stdout 14:23:55 INFO - Output received: 14:23:55 INFO - /builds/slave/test/build/application/firefox/firefox 14:23:55 INFO - Running post-action listener: _resource_record_post_action 14:23:55 INFO - ##### 14:23:55 INFO - ##### Finished install step (success) 14:23:55 INFO - ##### 14:23:55 INFO - ##### 14:23:55 INFO - ##### Running run-tests step. 14:23:55 INFO - ##### 14:23:55 INFO - Running pre-action listener: _resource_record_pre_action 14:23:55 INFO - Running main action method: run_tests 14:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:55 INFO - Python 2.7.3 14:23:55 INFO - Return code: 0 14:23:55 INFO - grabbing minidump binary from tooltool 14:23: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')]} 14:23:55 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 0x289d9c0>, '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 0x289e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:55 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 14:23:55 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 14:23:55 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 14:23:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:56 INFO - Return code: 0 14:23:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:23:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:23:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:23:56 INFO - Return code: 0 14:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:23:56 INFO - Using env: {'DISPLAY': ':0', 14:23:56 INFO - 'HOME': '/home/cltbld', 14:23:56 INFO - 'LANG': 'en_US.UTF-8', 14:23:56 INFO - 'LANGUAGE': 'en_US:en', 14:23:56 INFO - 'LOGNAME': 'cltbld', 14:23:56 INFO - 'MAIL': '/var/mail/cltbld', 14:23:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:56 INFO - 'MOZ_NO_REMOTE': '1', 14:23:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:23:56 INFO - 'NO_EM_RESTART': '1', 14:23:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:56 INFO - 'PWD': '/builds/slave/test', 14:23:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:56 INFO - 'SHELL': '/bin/bash', 14:23:56 INFO - 'SHLVL': '1', 14:23:56 INFO - 'TERM': 'linux', 14:23:56 INFO - 'TMOUT': '86400', 14:23:56 INFO - 'USER': 'cltbld', 14:23:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230', 14:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:56 INFO - '_': '/tools/buildbot/bin/python'} 14:23:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:23:57 INFO - mozversion application_buildid: 20160512113001 14:23:57 INFO - mozversion application_changeset: a97eec37ec2d4ded719ad996d75c431b7043fa5a 14:23:57 INFO - mozversion application_display_name: Nightly 14:23:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:57 INFO - mozversion application_name: Firefox 14:23:57 INFO - mozversion application_remotingname: firefox 14:23:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:23:57 INFO - mozversion application_vendor: Mozilla 14:23:57 INFO - mozversion application_version: 49.0a1 14:23:57 INFO - mozversion platform_buildid: 20160512113001 14:23:57 INFO - mozversion platform_changeset: a97eec37ec2d4ded719ad996d75c431b7043fa5a 14:23:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:23:57 INFO - mozversion platform_version: 49.0a1 14:23:57 INFO - using testdate: 1463088237 14:23:57 INFO - actual date: 1463088237 14:23:57 INFO - starting webserver on 'localhost:55819' 14:23:57 INFO - SUITE-START | Running 2 tests 14:23:57 INFO - TEST-START | dromaeo_css 14:23:57 INFO - operating with platform_type : linux_ 14:23:57 INFO - Initialising browser for dromaeo_css test... 14:23:57 INFO - TEST-INFO | started process 5520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKS3_EZ/profile http://localhost:55819/getInfo.html) 14:24:00 INFO - PROCESS | 5520 | __metrics Screen width/height:1600/1200 14:24:00 INFO - PROCESS | 5520 | colorDepth:24 14:24:00 INFO - PROCESS | 5520 | Browser inner width/height: 1024/697 14:24:00 INFO - PROCESS | 5520 | __metrics 14:24:01 ERROR - PROCESS | 5520 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:24:02 INFO - TEST-INFO | 5520: exit 0 14:24:02 INFO - Browser initialized. 14:24:02 INFO - Running cycle 1/1 for dromaeo_css test... 14:24:02 INFO - TEST-INFO | started process 5601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKS3_EZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:13 INFO - PROCESS | 5601 | RSS: Main: 150876160 14:24:13 INFO - PROCESS | 5601 | 14:25:05 INFO - PROCESS | 5601 | 1463088305285 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] 14:27:13 INFO - PROCESS | 5601 | Cycle 1(1): loaded http://localhost:55819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55819/tests/dromaeo/cssquery-ext.html) 14:27:14 INFO - PROCESS | 5601 | RSS: Main: 262590464 14:27:14 INFO - PROCESS | 5601 | 14:30:16 INFO - PROCESS | 5601 | Cycle 1(1): loaded http://localhost:55819/tests/dromaeo/cssquery-ext.html (next: http://localhost:55819/tests/dromaeo/cssquery-jquery.html) 14:30:16 INFO - PROCESS | 5601 | RSS: Main: 234172416 14:30:16 INFO - PROCESS | 5601 | 14:33:18 INFO - PROCESS | 5601 | Cycle 1(1): loaded http://localhost:55819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55819/tests/dromaeo/cssquery-mootools.html) 14:33:19 INFO - PROCESS | 5601 | RSS: Main: 242495488 14:33:19 INFO - PROCESS | 5601 | 14:36:21 INFO - PROCESS | 5601 | Cycle 1(1): loaded http://localhost:55819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55819/tests/dromaeo/cssquery-prototype.html) 14:36:21 INFO - PROCESS | 5601 | RSS: Main: 227053568 14:36:21 INFO - PROCESS | 5601 | 14:39:24 INFO - PROCESS | 5601 | Cycle 1(1): loaded http://localhost:55819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55819/tests/dromaeo/cssquery-yui.html) 14:39:25 INFO - PROCESS | 5601 | RSS: Main: 219648000 14:39:25 INFO - PROCESS | 5601 | 14:42:27 INFO - PROCESS | 5601 | Cycle 1(1): loaded http://localhost:55819/tests/dromaeo/cssquery-yui.html (next: http://localhost:55819/tests/dromaeo/cssquery-dojo.html) 14:42:28 INFO - PROCESS | 5601 | RSS: Main: 280711168 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | __start_tp_report 14:42:28 INFO - PROCESS | 5601 | _x_x_mozilla_page_load 14:42:28 INFO - PROCESS | 5601 | _x_x_mozilla_page_load_details 14:42:28 INFO - PROCESS | 5601 | |i|pagename|runs| 14:42:28 INFO - PROCESS | 5601 | |0;dojo.html;3142.8271445070523;3159.763017773666;3185.7610679199065;3201.375731732313;3225.5322978168165;5171.482851714826;5219.765110570024;5293.99414111319;5391.110466772982;5447.945520544793;5230.293910322105;5244.082285600024;5246.632735708502;5250.816221432251;5259.5529380002745;4765.690230135039;4793.808247670089;4794.592459640935;4860.9756951215195;4965.751712414383;4862.659613827033;4866.513348665123;4903.632227582928;4907.386576677915;4930.506949305077;4683.742394168303;4687.968646897677;4694.718316900997;4736.715797052188;4742.881427964311;4693.530646935314;4781.450133234688;4794.520547945178;4796.640251981115;4803.56767890888;4687.5781179693995;4737.526247375235;4749.26386410107;4756.334113224151;4787.880302992418;5205.973970130163;5213.791448342062;5225.581953443753;5237.3453318335205;5245.370555533323;5589.301337332833;5602.635828671164;5608.298962629671;5616.32604087508;5630.4369563043365;5504.862378440531;5565.693886836222;5585.469380408855;5733.971330143323;5756.222909907151;5307.893842123174;5308.309919710413;5322.387925388591;5333.986542556941;5343.145096784496;5774.3070831499645;5776.191333213354;5791.652500849878;5822.94177058224;5835.474807267281;5410.1614249790555;5554.6944918029085;5570.303712035996;5584.553235741131;5587.69267690281;5734.684592347461;5736.397678243724;5738.885222295531;5745.511631511368;5765.913511297334;5667.866426714673;5677.120046392815;5679.460451257124;5681.147827825776;5700.458456446631;5374.596905232123;5563.415841336682;5629.943700563023;5673.687947162945;5697.943020569741;4325.286327755948;4331.306990881444;4332.436783218224;4333.111712099075;4367;3770.377887648507;3873.973397049784;3874.8837534874;3920.4511368408444;3937.330653788863;5043.041822053798;5170.250313704491;5217.06092903281;5226.425093239741;5229.50319719626;5514;5551.916721249185;5561.082421400504;5604.85987850307;5624.268845050117;5213;5239.764210610456;5279.656822306538;5293.867653308698;5298.7350632469;4853.805847766121;4856.854294371175;4874.634402419832;4900.828471003498;4902.338184345068;5866.413358664099;5877.823665290048;5888.793892213752;5896.852578685482;5906.734196961147;5389.1107967186545;5655.321361436654;5688.402717714746;5700.657960522382;5703.714814259188;5847.210626565359;5861.706914654335;5898.174255604133;5910.261217347832;5954.821355359346;5537.529310008695;5627.296587926509;5633.2113504110275;5646.604737668324;5651.4348565143155;5451.918221226605;5590.86022849432;5610.831675049755;5626.184203290418;5660.801871934463;5496.120620700669;5508.779648814003;5509.889802204014;5511.751971161227;5537.8061767837935;5461.535769459481;5506.614536982373;5526.91709624364;5541.916871246854;5619.859503512282;5379.596530260168;5394.406615272238;5411.404745477916;5430.968116057937;5436.809711660073;5533.142362933751;5546.140348245867;5546.7781288748;5581.944180558305;5584.581156413366;5303.098473259633;5397.730113494231;5409.188621706776;5475.863103422446;5492.505674489155 14:42:28 INFO - PROCESS | 5601 | |1;ext.html;566.8072855229221;593.2495393327439;600.2137200267648;605.9424354686304;609.7500024989753;32796.67203327966;35671.28657426853;35706;35798.642013579854;36911.81544092276;45767.77116114415;46158;46467.53532464674;46491.30263046049;46546.534534654646;8730.476171429718;8816.118388161165;8862.822743545124;8879.978802437738;8906.153915378061;8729.738107856774;8768.386212965095;8777.078406767294;8829;8852.867206991868;8786.824263514725;8832.779180520507;8836.42563233391;8881.822363552725;8884.644614215424;8686.478811271343;8755.299576033902;8810.163034511743;8819.691310804123;8829.11708829112;8626.525541095238;8633.179847914438;8636.82726345476;8706.216440520384;8718.825623487559;40131;40590.1881962362;40637.18725625471;40672.38991415131;40784.38823417651;3374;3519.5072689823446;3568.0544655666267;3825.674817640504;3997.200559888034;32431.351372972407;32493.350132997442;32729.836350818092;33139.2329204955;33170.17074573131;4222.514410842762;4275.894151823926;4317.0934103838235;4331.523532411432;4343.913121737579;323966;324775;325317.3734131338;326668;327567;57921;57937.71031144817;58367;58522.4147758517;58787.70606146942;52080;53340.73329633327;56150.7192464035;61754.69122654358;61788.69105654533;16048.27782749779;16309.59226019359;16326.265318060716;16339.50981470534;16390.098544579923;12526.624201273977;12639.810402843965;12672;12678.936605316914;12679.873201268054;16083.678326433639;17569.20938557768;17657.911710441622;18168.273269069352;18766.437006889813;6648.966755166193;6656.966715166393;6726.452915829386;6736.6631668416385;6741.932580674229;988.5057471264367;1016.5730393234859;1029.2023681646633;1102.652664410708;1124;31939.680603194134;31954.36091278208;32013;32617;32744.345113097606;1168.9532418703327;1181.0197536045061;1192.439553409896;1218.7318789866215;1255.1276862580419;17055.914720426317;17219.741703874453;17324.480265592054;17367.826321736873;17445.30218791234;436352;437092;438169.473221074;438995;439616;58330.70834645884;58335.416645833844;58478.70760646254;58484;58558.41441585615;1277.2528071078523;1391.1027387335112;1414.6675531250148;1503.488813803312;1592.7371983622572;29881.252968675955;32989;33737.828912858036;33996.830015849766;34144.82927585346;51199.74400127975;51690.74154629353;52119;52492.47507524876;52749.47250527599;391655;394720;396106;396269;396508;38291.808540957114;43269.567304326556;43798.56201437945;44440;44460.77769611131;45058.09883802371;48584;48997.75501122472;49049.5095049045;49394.75302623464;40165.79917100396;41444.585554144076;41771.98736151681;41999.58000420079;42153.36769948515;41396.586034139276;41478.170436590495;41698.58301417068;41705.79147104245;42597.78701106475;40030.39954400744;40272.597274026884;41350.37974430326;41634.1673166541;41913.79043104765;35135;36793.08017299589;36798.63201367952;36865;37239.25521489609;27838.582421264102;27960.30099247454;28150.436991259652;28375.858120709265;28451.573226401208 14:42:28 INFO - PROCESS | 5601 | |2;jquery.html;404.74096578189955;406.6827874258078;407.9041425265064;416.09499338937803;421.3700517726;13863.722725545484;18088.54778630533;19804.504887377785;19919.900400497994;19947.50131246718;14453.92773036136;17668.204930778113;17792.911035444806;19233.32683356083;20045.398638040882;5559.388467268597;5730.484256416921;5745.971270143644;5747.971260143693;5757.251557297545;5595.160725891128;5635.690037047961;5709.343425506057;5735.168400581913;5756.424357564231;4076.510818701745;5985.401459854023;6313.621182729051;6322.304546499904;6433.8391540211405;6241.407066328691;6344.302126766052;6373.0759039939185;6408.839779005515;6410.967945160291;5572.60991730575;5718.771249150071;5720.1991721159075;5739.110437882135;5744.942550574483;22191.44521386962;22870.542589148125;23473.178438754563;23535.882320588287;23721.525569488513;2374.169040835711;2432.3554258121612;2522.823402361835;2837.205582436921;3155.1165673611426;14374.496892608813;14562.927185364111;14647.487337943121;14668.26658667073;14931.552053438414;1961.8626696131278;2028.503016760903;2064.649009668345;2074.367317968019;2107.3783233946024;86988.56505717494;89165;89721;89735.55132224363;90235.54882225613;10772.245942784086;11082.16883733707;11197.216194866282;11201.103911687045;11342.20604557673;15522.379104835905;15659.765103523456;15681.13753743555;15711.842881571038;15745.44890928812;8110.148434414302;8216.630251638691;8315.83368332642;8414.957925210334;8460.957695211608;7931.127575966639;7937.3650107991225;7954.5624990626075;8036.517808931483;8057.153998830156;6028.3971602839365;6448;6826.488013398915;6932.272111428228;6973.232944376216;1907.5612609099708;1944.9398682781414;1987.3839109875985;1998.230681187724;2003.7996200379846;948.5589201021559;1056.0917610854658;1065.5844220753913;1078.3152698036804;1119.255694962857;19486.317978870957;19877;19982.70025949612;19994.100265488087;20090.598188036158;1062.5218651606808;1063.4629512096342;1127.6504283672089;1139.7549526851767;1168.6786133813268;11068.667939961813;11298.265612735311;11318.862453826885;11459.369734664508;11517.712057198638;478987;482205;483894;488761;499063;84511.5774421124;84555.57722211472;84661.15338846533;84741.57629211814;86362.80104699105;1068.6526878764432;1070.1599244593112;1070.6734445994045;1070.6895000449783;1090.536521978156;15991.760123597922;16984.40554580584;17107.7433838495;17966.371177008743;18225.635487290445;30914.227144321572;35471.93584192478;36275.27449451049;37083.443748343256;42619.360709588764;47588.52411475979;49735.25397118974;52950.4704952961;54738.452615474926;55803.16295255493;8896.421732587361;8986.236169925369;9195.758572592615;9273.536323183678;9305.395149315273;8549.786255343666;13404.530841420503;13536.729265414833;13822.101563398346;14143.292835358397;11712.590059347882;12099.274043557414;12104.75790484203;12274.631761047183;12334.81497777516;11989.280643161439;12017.75964480688;12055.276683399024;12111.81832272499;12339.13626046168;11928.642140735792;12176.33030183313;12398.938005309916;12399.75200496003;12582.622521324374;8945;9108.681196158102;9174.311926605398;9292.442453452815;9414.529273536158;11394.943025285153;11689.88310116888;11806.173567850512;12095.81856272139;12172.695682607651 14:42:28 INFO - PROCESS | 5601 | |3;mootools.html;1355.647531641774;1529.090191336155;1566.1386237569336;1733.904635245061;1859.9907000464996;7890.171531989137;8166.183381661838;8550.828983420335;8740.51927144007;8798.6920457784;8468.957655211716;8677.088905664908;8718.084601116887;8749;8763.95618021909;2061.2270398600526;2262.1403866530695;2322.756110608383;2353.95292094158;2356.257778799681;2340.0756701103055;2357.669926210332;2365.2549446924163;2365.9645105323348;2375.3824005758543;2295.426143464134;2342.02805835578;2351.870647114408;2352.647102934565;2354.5290941811622;2042.28520017994;2285.645724912641;2356.929292121239;2361.480474295652;2376.942260693992;2221.1670623516184;2242.5963326601204;2242.955140897173;2243.214874793809;2264.8980795864227;8656.43733157349;8703.6518539259;8707.956460217658;8723.084076171974;8724.127587241224;5181.792728290864;5315.468453154692;5319.0957537218765;5321.388040375367;5357.678539287616;3288.901332960015;3448.7241020718284;3459.066052165926;3468.2543253200683;3531.841067151984;1160.4545863444168;1193.7135087579006;1198.6583823610317;1235.882591153839;1242.465739731915;12104.39478026104;12164;12173.147879648517;12185.32980686062;12212.572559960448;4521.253993091169;4554.453465584151;4598.563136502027;4615.330777037378;4624.375709279271;9655.951720241354;9697;9697.951510242403;9716;9724.902750972542;4717.858464246078;5254.211868219798;5269.762860671279;5277.313949186581;5305.973470132624;4671.696339737974;4819.783109760069;4829.154897892855;4846.321514987904;4853.830115945925;3756.9436458453147;3800.0689830991582;3813.980930095387;3870.3807390817333;3920.1179734560064;1120.2774210634095;1122.2032357026603;1123.3035517978906;1127.9323240605427;1153.8211577205548;990.1138481059412;995.6216637677636;997.5760301871676;1006.8489726541078;1012.9949350253202;5807.709614519342;5850;5875.471207591252;5944.762209511658;6071.119687645267;453.5691093461225;459.46013434214666;461.73681001828635;971.2472833554052;1010.5856598794606;4001.6198461146146;4065.0853557949818;4086.7956602169775;4103.692223083281;4105.753654780723;9764;9958.203343732484;9964.501774911225;10060.144887684628;10071.093601575893;9814.165795907285;9902.009799020185;9988.900110998797;10112.848307275397;10168;7515.248475152441;8282.13037631052;8305.335573154132;8324.958375208207;8424.747257582283;5750.30996280449;5806.2451881255165;5806.912896306474;5881.529477641864;5929.495992840484;10012.799744004933;10033.347832390871;10095.242856785917;10243.129334006693;10249.077583017564;9669.9033009669;10223.642172523925;10310.793784124426;10396.220283478619;10425.374477531372;6485.319041500575;7091.82270443243;7284.635768211674;7501.699932002659;7630.351420129351;8568.57157142153;8581.227689507974;8646.351523635627;8671.132886711279;8698.21716045559;7620.80947976305;7859.253370929752;7901.604919754104;7976.441649084741;8059.314958228616;7595.810104747205;7625.885611715939;7688.077430708351;7731.265529774662;7772.261635144652;7015.193252775996;7086.822829429099;7107.395871350786;7127.287271272831;7146.3568278855155;4865.5864251539015;4948.554630083309;5032.773525191448;5053.242013697828;5105.897882042264;5085.338905942203;5106.183010718267;5123.052235336475;5231.450697676842;5289.656172348785 14:42:28 INFO - PROCESS | 5601 | |4;prototype.html;338.5598721661839;342.0985702673455;347.63324692449464;352.70020482589786;354.47537644286473;5117.488251174881;5171.7414129293575;5172.379314482263;5225.86935326617;5232.064136269586;4877.926831097528;4975.925361119586;5118.872028199287;5145.224897410388;5154.6134039946965;4043.60495629009;4070.633642972132;4077.6951375559834;4096.467459230304;4118.258713431581;4083.2650122977852;4084.8978775530554;4093.488313960755;4108.548059713429;4134.8139333729905;3889.277505745975;3973.662238709713;4020.718549701522;4032.9798351008203;4093.97953010236;4024.7383920045395;4029.97985010076;4032.3749818778138;4049.088954985134;4051.5745846686114;3626.4197728363597;3632.691221246197;3632.981835090834;3640.3265395901576;3643.7995910224927;4690.788914498821;4969.478204788481;4986.60375094974;4993.950060499385;5040.84877453677;4586.449626044862;4593.54064593538;4607.953920460786;4628.842789302675;4647.442306923191;5371.328583927009;5372.086745253317;5392.649477783932;5400.351957765054;5427.972860135714;3831.0230891122865;3937.232239713257;3939.9212015759813;3940.271049855757;3953.9011524711823;5537.944620553783;5555.805546805843;5555.833325000256;5556.444355564411;5587.552995760329;3980.601939805996;3983.900402489961;3988.481497405319;4003.199360127986;4008;3931.8034098295543;4033.7378070425916;4055.6552693020835;4060.167665628539;4070.5929407059057;4482.408744895581;4573.314002899591;4589.311603259471;4601.907961840744;4625.450474091217;5354.892902141935;5364.275822763877;5374.280230326258;5425.6202065855805;5427.348718153847;1311.8294621699117;1355.7898525728529;1400.1109295597369;1420.4105296302125;1422.8830368160943;881.4711173296099;894.6689724801865;909.60432211988;912.4662072687552;915.4553040940763;4543.341215523797;4546.522615125365;4558.817647294071;4615.945904072655;4631.444226692751;4729.266963620645;4752.928706069411;4783.354247176656;4793.736344501086;4857.805687772449;4521.050579378301;4555.40779698637;4564.657650676146;4594.1271158479785;4617.8152873884665;2392.2225276785116;2531.582288922344;2569.588865781466;2602.596597527386;2602.8568428736603;4894.853154405374;4960.677555958851;4961.330220420269;5007.924881126786;5034.521720436553;4828.609838130078;4841.225403935354;4864.489228630943;4869.2939523768855;4876.951230487721;5258.526732594085;5711.942880571224;5723.742431590588;5737.627054241461;5741.5406767459335;5445.537129343892;5446.210299506629;5466.508014278734;5498.972505137449;5532.861678458071;5217.982493413748;5451.509364157087;5516.675997760428;5542.445755424425;5551.861203469945;5724.599278050497;5730.341010783646;5745.052066408995;5757.251557297524;5762.481376676119;4022.718409711292;4061.005053761847;4062.5734297899476;4065.8576949806616;4071.6156506787834;5298.655587386807;5342.675935967866;5536.861578460571;5619.269494965628;5625.634333768292;5242.97378513105;5430.891382172414;5438.293021907127;5450.236966824568;5465.59008074388;5396.676199428047;5427.294451721251;5431.212474191299;5441.80280338325;5465.590080744039;5263.499967503081;5333.626646134733;5353.652012619167;5375.704336261543;5376.274202982548;5367.1680889462195;5514.691185288794;5517.372375149421;5528.668279903219;5543.1408131739645;5312.840614781563;5331.093714068696;5386.43442438554;5403.729813509387;5410.161424979135 14:42:28 INFO - PROCESS | 5601 | |5;yui.html;764.9311561959423;781.4959351218461;788.0740130346844;813.7029984055821;830.236182711905;13099.803502947452;14808.16065796304;14910;15105.62235944102;15233.695326093472;13791.172529648227;13954.930225348884;13978.440862365518;13990.3704333305;13999.440022399118;688.896665500174;803.2369249213256;807.2169995104739;825.1624601029929;827.0571548434759;827.8096037911284;827.9213474719892;832.196929962586;833.1085738260064;834.1158372125536;870.3254977392509;871.3203701113142;871.3900269811126;873.2010210657241;877.1447838357614;722.238038868993;850.4259624753298;855.9101294364127;866.1728049712509;873.2839071960994;635.8505751148523;637.8532937424418;637.9202599675041;638.1162090504638;641.2785616181795;14322.498712545115;14364.856351436561;14385.71228575433;14397.136171829723;14445;13333.200007999454;13647.11293765912;13724.519641812589;13836.930815345959;13931;11884.584039558575;12020.278783273032;12038.4582693779;12282.14025018249;12352.752944941141;4374.540673229297;4435.135148646015;4478.529754375776;4566.840160594364;4595.080983803219;53372.46627533752;54134.18798718022;54544.45455545434;54912;55149;10929.234953553176;11090.279131856403;11293.943530282297;11346.659600212008;11357.318560886373;19897.403077907686;19917.900410497856;19965.500862478555;20001.199952002047;20006.799932000784;7931.325837303893;7972.641231144612;8086.83826323482;8290.8341833163;8393.454425462325;4604.562566556172;4624.375709279271;4743;4792.760361981887;4847.830325938646;3263.3147039121577;3327.617324007722;3408.744344174197;3423.8972830815114;3425.520427140202;686.660103248895;691.9688614012382;708.4509505133562;716.7419728897593;727.1092911183863;591.6538824787548;659.6553596997919;709.3119673916293;738.9838971414306;740.0675149311905;9298;9858.852117218248;9951.55218015191;10077.647282345082;10184.847227291597;719.2663483247059;725.5864157430215;730.4229658569776;745.3850573277068;761.7524304601027;4204.138151678899;4843.39457567804;4904.215325547895;5142.023015627019;5152.330197074356;63274;66660.66669666718;67927.66036169886;67998;68403;58681.70659146677;59597.40402596005;60109.69945150246;60170.69914650399;60726;53208.54144480674;54125.45874541283;54263.72868135634;54316;54716.45283547193;9574.281928855224;9917.603295868374;9994.900050999688;10020.24848136378;10065.194784417376;34146.829265853514;34461.13847153841;35380;35453.46819797757;35748.28503429969;43542.56457435385;45413.545864542255;47646.761766190946;47799;48833;12406.503739850305;12436.129470936947;12520.686982825502;12578.496860125859;12585.748285034431;14233.786493202404;14374.425022998963;14633.926830365781;15016.699666006838;15143.394264229308;12549.874501255235;13039.869601303866;13626.863731362955;13836;14162.504312349018;13126.081174317706;13385.330733463483;13708.725825483634;14006.089604175697;14105.224212668401;12796.680082998;13361.465541378237;13393.665158370728;13588;13620.863791362355;10682.252242342962;10714.19643526723;10745.570177192825;10893.291936024134;11204.327740335606;11304.660860174208;11328.376939268419;11336.149788765711;11451.255668381862;11474.4262786862 14:42:28 INFO - PROCESS | 5601 | __end_tp_report 14:42:28 INFO - PROCESS | 5601 | __start_cc_report 14:42:28 INFO - PROCESS | 5601 | _x_x_mozilla_cycle_collect,824 14:42:28 INFO - PROCESS | 5601 | __end_cc_report 14:42:28 INFO - PROCESS | 5601 | __startTimestamp1463089348103__endTimestamp 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | ------- Summary: start ------- 14:42:28 INFO - PROCESS | 5601 | Number of tests: 6 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | [#0] dojo.html Cycles:165 Average:5241.93 Median:5411.40 stddev:582.53 (10.8%) stddev-sans-first:560.56 14:42:28 INFO - PROCESS | 5601 | Values: 3142.8 3159.8 3185.8 3201.4 3225.5 5171.5 5219.8 5294.0 5391.1 5447.9 5230.3 5244.1 5246.6 5250.8 5259.6 4765.7 4793.8 4794.6 4861.0 4965.8 4862.7 4866.5 4903.6 4907.4 4930.5 4683.7 4688.0 4694.7 4736.7 4742.9 4693.5 4781.5 4794.5 4796.6 4803.6 4687.6 4737.5 4749.3 4756.3 4787.9 5206.0 5213.8 5225.6 5237.3 5245.4 5589.3 5602.6 5608.3 5616.3 5630.4 5504.9 5565.7 5585.5 5734.0 5756.2 5307.9 5308.3 5322.4 5334.0 5343.1 5774.3 5776.2 5791.7 5822.9 5835.5 5410.2 5554.7 5570.3 5584.6 5587.7 5734.7 5736.4 5738.9 5745.5 5765.9 5667.9 5677.1 5679.5 5681.1 5700.5 5374.6 5563.4 5629.9 5673.7 5697.9 4325.3 4331.3 4332.4 4333.1 4367.0 3770.4 3874.0 3874.9 3920.5 3937.3 5043.0 5170.3 5217.1 5226.4 5229.5 5514.0 5551.9 5561.1 5604.9 5624.3 5213.0 5239.8 5279.7 5293.9 5298.7 4853.8 4856.9 4874.6 4900.8 4902.3 5866.4 5877.8 5888.8 5896.9 5906.7 5389.1 5655.3 5688.4 5700.7 5703.7 5847.2 5861.7 5898.2 5910.3 5954.8 5537.5 5627.3 5633.2 5646.6 5651.4 5451.9 5590.9 5610.8 5626.2 5660.8 5496.1 5508.8 5509.9 5511.8 5537.8 5461.5 5506.6 5526.9 5541.9 5619.9 5379.6 5394.4 5411.4 5431.0 5436.8 5533.1 5546.1 5546.8 5581.9 5584.6 5303.1 5397.7 5409.2 5475.9 5492.5 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | [#1] ext.html Cycles:180 Average:55878.50 Median:41461.38 stddev:102428.22 (247.0%) stddev-sans-first:102631.37 14:42:28 INFO - PROCESS | 5601 | Values: 566.8 593.2 600.2 605.9 609.8 32796.7 35671.3 35706.0 35798.6 36911.8 45767.8 46158.0 46467.5 46491.3 46546.5 8730.5 8816.1 8862.8 8880.0 8906.2 8729.7 8768.4 8777.1 8829.0 8852.9 8786.8 8832.8 8836.4 8881.8 8884.6 8686.5 8755.3 8810.2 8819.7 8829.1 8626.5 8633.2 8636.8 8706.2 8718.8 40131.0 40590.2 40637.2 40672.4 40784.4 3374.0 3519.5 3568.1 3825.7 3997.2 32431.4 32493.4 32729.8 33139.2 33170.2 4222.5 4275.9 4317.1 4331.5 4343.9 323966.0 324775.0 325317.4 326668.0 327567.0 57921.0 57937.7 58367.0 58522.4 58787.7 52080.0 53340.7 56150.7 61754.7 61788.7 16048.3 16309.6 16326.3 16339.5 16390.1 12526.6 12639.8 12672.0 12678.9 12679.9 16083.7 17569.2 17657.9 18168.3 18766.4 6649.0 6657.0 6726.5 6736.7 6741.9 988.5 1016.6 1029.2 1102.7 1124.0 31939.7 31954.4 32013.0 32617.0 32744.3 1169.0 1181.0 1192.4 1218.7 1255.1 17055.9 17219.7 17324.5 17367.8 17445.3 436352.0 437092.0 438169.5 438995.0 439616.0 58330.7 58335.4 58478.7 58484.0 58558.4 1277.3 1391.1 1414.7 1503.5 1592.7 29881.3 32989.0 33737.8 33996.8 34144.8 51199.7 51690.7 52119.0 52492.5 52749.5 391655.0 394720.0 396106.0 396269.0 396508.0 38291.8 43269.6 43798.6 44440.0 44460.8 45058.1 48584.0 48997.8 49049.5 49394.8 40165.8 41444.6 41772.0 41999.6 42153.4 41396.6 41478.2 41698.6 41705.8 42597.8 40030.4 40272.6 41350.4 41634.2 41913.8 35135.0 36793.1 36798.6 36865.0 37239.3 27838.6 27960.3 28150.4 28375.9 28451.6 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | [#2] jquery.html Cycles:180 Average:28901.46 Median:23504.53 stddev:80132.37 (340.9%) stddev-sans-first:80328.60 14:42:28 INFO - PROCESS | 5601 | Values: 404.7 406.7 407.9 416.1 421.4 13863.7 18088.5 19804.5 19919.9 19947.5 14453.9 17668.2 17792.9 19233.3 20045.4 5559.4 5730.5 5746.0 5748.0 5757.3 5595.2 5635.7 5709.3 5735.2 5756.4 4076.5 5985.4 6313.6 6322.3 6433.8 6241.4 6344.3 6373.1 6408.8 6411.0 5572.6 5718.8 5720.2 5739.1 5744.9 22191.4 22870.5 23473.2 23535.9 23721.5 2374.2 2432.4 2522.8 2837.2 3155.1 14374.5 14562.9 14647.5 14668.3 14931.6 1961.9 2028.5 2064.6 2074.4 2107.4 86988.6 89165.0 89721.0 89735.6 90235.5 10772.2 11082.2 11197.2 11201.1 11342.2 15522.4 15659.8 15681.1 15711.8 15745.4 8110.1 8216.6 8315.8 8415.0 8461.0 7931.1 7937.4 7954.6 8036.5 8057.2 6028.4 6448.0 6826.5 6932.3 6973.2 1907.6 1944.9 1987.4 1998.2 2003.8 948.6 1056.1 1065.6 1078.3 1119.3 19486.3 19877.0 19982.7 19994.1 20090.6 1062.5 1063.5 1127.7 1139.8 1168.7 11068.7 11298.3 11318.9 11459.4 11517.7 478987.0 482205.0 483894.0 488761.0 499063.0 84511.6 84555.6 84661.2 84741.6 86362.8 1068.7 1070.2 1070.7 1070.7 1090.5 15991.8 16984.4 17107.7 17966.4 18225.6 30914.2 35471.9 36275.3 37083.4 42619.4 47588.5 49735.3 52950.5 54738.5 55803.2 8896.4 8986.2 9195.8 9273.5 9305.4 8549.8 13404.5 13536.7 13822.1 14143.3 11712.6 12099.3 12104.8 12274.6 12334.8 11989.3 12017.8 12055.3 12111.8 12339.1 11928.6 12176.3 12398.9 12399.8 12582.6 8945.0 9108.7 9174.3 9292.4 9414.5 11394.9 11689.9 11806.2 12095.8 12172.7 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | [#3] mootools.html Cycles:180 Average:5690.44 Median:4907.07 stddev:3195.85 (65.1%) stddev-sans-first:3188.21 14:42:28 INFO - PROCESS | 5601 | Values: 1355.6 1529.1 1566.1 1733.9 1860.0 7890.2 8166.2 8550.8 8740.5 8798.7 8469.0 8677.1 8718.1 8749.0 8764.0 2061.2 2262.1 2322.8 2354.0 2356.3 2340.1 2357.7 2365.3 2366.0 2375.4 2295.4 2342.0 2351.9 2352.6 2354.5 2042.3 2285.6 2356.9 2361.5 2376.9 2221.2 2242.6 2243.0 2243.2 2264.9 8656.4 8703.7 8708.0 8723.1 8724.1 5181.8 5315.5 5319.1 5321.4 5357.7 3288.9 3448.7 3459.1 3468.3 3531.8 1160.5 1193.7 1198.7 1235.9 1242.5 12104.4 12164.0 12173.1 12185.3 12212.6 4521.3 4554.5 4598.6 4615.3 4624.4 9656.0 9697.0 9698.0 9716.0 9724.9 4717.9 5254.2 5269.8 5277.3 5306.0 4671.7 4819.8 4829.2 4846.3 4853.8 3756.9 3800.1 3814.0 3870.4 3920.1 1120.3 1122.2 1123.3 1127.9 1153.8 990.1 995.6 997.6 1006.8 1013.0 5807.7 5850.0 5875.5 5944.8 6071.1 453.6 459.5 461.7 971.2 1010.6 4001.6 4065.1 4086.8 4103.7 4105.8 9764.0 9958.2 9964.5 10060.1 10071.1 9814.2 9902.0 9988.9 10112.8 10168.0 7515.2 8282.1 8305.3 8325.0 8424.7 5750.3 5806.2 5806.9 5881.5 5929.5 10012.8 10033.3 10095.2 10243.1 10249.1 9669.9 10223.6 10310.8 10396.2 10425.4 6485.3 7091.8 7284.6 7501.7 7630.4 8568.6 8581.2 8646.4 8671.1 8698.2 7620.8 7859.3 7901.6 7976.4 8059.3 7595.8 7625.9 7688.1 7731.3 7772.3 7015.2 7086.8 7107.4 7127.3 7146.4 4865.6 4948.6 5032.8 5053.2 5105.9 5085.3 5106.2 5123.1 5231.5 5289.7 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | [#4] prototype.html Cycles:180 Average:4453.69 Median:4877.44 stddev:1298.06 (26.6%) stddev-sans-first:1264.42 14:42:28 INFO - PROCESS | 5601 | Values: 338.6 342.1 347.6 352.7 354.5 5117.5 5171.7 5172.4 5225.9 5232.1 4877.9 4975.9 5118.9 5145.2 5154.6 4043.6 4070.6 4077.7 4096.5 4118.3 4083.3 4084.9 4093.5 4108.5 4134.8 3889.3 3973.7 4020.7 4033.0 4094.0 4024.7 4030.0 4032.4 4049.1 4051.6 3626.4 3632.7 3633.0 3640.3 3643.8 4690.8 4969.5 4986.6 4994.0 5040.8 4586.4 4593.5 4608.0 4628.8 4647.4 5371.3 5372.1 5392.6 5400.4 5428.0 3831.0 3937.2 3939.9 3940.3 3953.9 5537.9 5555.8 5555.8 5556.4 5587.6 3980.6 3983.9 3988.5 4003.2 4008.0 3931.8 4033.7 4055.7 4060.2 4070.6 4482.4 4573.3 4589.3 4601.9 4625.5 5354.9 5364.3 5374.3 5425.6 5427.3 1311.8 1355.8 1400.1 1420.4 1422.9 881.5 894.7 909.6 912.5 915.5 4543.3 4546.5 4558.8 4615.9 4631.4 4729.3 4752.9 4783.4 4793.7 4857.8 4521.1 4555.4 4564.7 4594.1 4617.8 2392.2 2531.6 2569.6 2602.6 2602.9 4894.9 4960.7 4961.3 5007.9 5034.5 4828.6 4841.2 4864.5 4869.3 4877.0 5258.5 5711.9 5723.7 5737.6 5741.5 5445.5 5446.2 5466.5 5499.0 5532.9 5218.0 5451.5 5516.7 5542.4 5551.9 5724.6 5730.3 5745.1 5757.3 5762.5 4022.7 4061.0 4062.6 4065.9 4071.6 5298.7 5342.7 5536.9 5619.3 5625.6 5243.0 5430.9 5438.3 5450.2 5465.6 5396.7 5427.3 5431.2 5441.8 5465.6 5263.5 5333.6 5353.7 5375.7 5376.3 5367.2 5514.7 5517.4 5528.7 5543.1 5312.8 5331.1 5386.4 5403.7 5410.2 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - PROCESS | 5601 | [#5] yui.html Cycles:180 Average:15527.60 Median:4580.96 stddev:18047.71 (394.0%) stddev-sans-first:18064.29 14:42:28 INFO - PROCESS | 5601 | Values: 764.9 781.5 788.1 813.7 830.2 13099.8 14808.2 14910.0 15105.6 15233.7 13791.2 13954.9 13978.4 13990.4 13999.4 688.9 803.2 807.2 825.2 827.1 827.8 827.9 832.2 833.1 834.1 870.3 871.3 871.4 873.2 877.1 722.2 850.4 855.9 866.2 873.3 635.9 637.9 637.9 638.1 641.3 14322.5 14364.9 14385.7 14397.1 14445.0 13333.2 13647.1 13724.5 13836.9 13931.0 11884.6 12020.3 12038.5 12282.1 12352.8 4374.5 4435.1 4478.5 4566.8 4595.1 53372.5 54134.2 54544.5 54912.0 55149.0 10929.2 11090.3 11293.9 11346.7 11357.3 19897.4 19917.9 19965.5 20001.2 20006.8 7931.3 7972.6 8086.8 8290.8 8393.5 4604.6 4624.4 4743.0 4792.8 4847.8 3263.3 3327.6 3408.7 3423.9 3425.5 686.7 692.0 708.5 716.7 727.1 591.7 659.7 709.3 739.0 740.1 9298.0 9858.9 9951.6 10077.6 10184.8 719.3 725.6 730.4 745.4 761.8 4204.1 4843.4 4904.2 5142.0 5152.3 63274.0 66660.7 67927.7 67998.0 68403.0 58681.7 59597.4 60109.7 60170.7 60726.0 53208.5 54125.5 54263.7 54316.0 54716.5 9574.3 9917.6 9994.9 10020.2 10065.2 34146.8 34461.1 35380.0 35453.5 35748.3 43542.6 45413.5 47646.8 47799.0 48833.0 12406.5 12436.1 12520.7 12578.5 12585.7 14233.8 14374.4 14633.9 15016.7 15143.4 12549.9 13039.9 13626.9 13836.0 14162.5 13126.1 13385.3 13708.7 14006.1 14105.2 12796.7 13361.5 13393.7 13588.0 13620.9 10682.3 10714.2 10745.6 10893.3 11204.3 11304.7 11328.4 11336.1 11451.3 11474.4 14:42:28 INFO - PROCESS | 5601 | -------- Summary: end -------- 14:42:28 INFO - PROCESS | 5601 | 14:42:28 INFO - TEST-INFO | 5601: exit 0 14:42:28 INFO - TEST-OK | dromaeo_css | took 1111515ms 14:42:28 INFO - TEST-START | kraken 14:42:28 INFO - operating with platform_type : linux_ 14:42:28 INFO - Initialising browser for kraken test... 14:42:28 INFO - TEST-INFO | started process 5786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD3jZ74/profile http://localhost:55819/getInfo.html) 14:42:32 INFO - PROCESS | 5786 | __metrics Screen width/height:1600/1200 14:42:32 INFO - PROCESS | 5786 | colorDepth:24 14:42:32 INFO - PROCESS | 5786 | Browser inner width/height: 1024/697 14:42:32 INFO - PROCESS | 5786 | __metrics 14:42:33 ERROR - PROCESS | 5786 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:42:33 INFO - TEST-INFO | 5786: exit 0 14:42:33 INFO - Browser initialized. 14:42:33 INFO - Running cycle 1/1 for kraken test... 14:42:33 INFO - TEST-INFO | started process 5865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD3jZ74/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:45 INFO - PROCESS | 5865 | RSS: Main: 151396352 14:42:45 INFO - PROCESS | 5865 | 14:42:47 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55819/tests/kraken/driver.html?testName=audio-beat-detection) 14:42:48 INFO - PROCESS | 5865 | RSS: Main: 208076800 14:42:48 INFO - PROCESS | 5865 | 14:42:51 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55819/tests/kraken/driver.html?testName=audio-dft) 14:42:51 INFO - PROCESS | 5865 | RSS: Main: 195149824 14:42:51 INFO - PROCESS | 5865 | 14:42:55 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55819/tests/kraken/driver.html?testName=audio-fft) 14:42:55 INFO - PROCESS | 5865 | RSS: Main: 263872512 14:42:55 INFO - PROCESS | 5865 | 14:42:57 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55819/tests/kraken/driver.html?testName=audio-oscillator) 14:42:58 INFO - PROCESS | 5865 | RSS: Main: 173436928 14:42:58 INFO - PROCESS | 5865 | 14:43:00 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:01 INFO - PROCESS | 5865 | RSS: Main: 178429952 14:43:01 INFO - PROCESS | 5865 | 14:43:04 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55819/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:05 INFO - PROCESS | 5865 | RSS: Main: 214097920 14:43:05 INFO - PROCESS | 5865 | 14:43:08 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55819/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:09 INFO - PROCESS | 5865 | RSS: Main: 211525632 14:43:09 INFO - PROCESS | 5865 | 14:43:12 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55819/tests/kraken/driver.html?testName=json-parse-financial) 14:43:12 INFO - PROCESS | 5865 | RSS: Main: 212316160 14:43:12 INFO - PROCESS | 5865 | 14:43:14 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:14 INFO - PROCESS | 5865 | RSS: Main: 200736768 14:43:14 INFO - PROCESS | 5865 | 14:43:16 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:17 INFO - PROCESS | 5865 | RSS: Main: 204988416 14:43:17 INFO - PROCESS | 5865 | 14:43:19 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:43:20 INFO - PROCESS | 5865 | RSS: Main: 213954560 14:43:20 INFO - PROCESS | 5865 | 14:43:22 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:43:23 INFO - PROCESS | 5865 | RSS: Main: 219713536 14:43:23 INFO - PROCESS | 5865 | 14:43:26 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:43:27 INFO - PROCESS | 5865 | RSS: Main: 219181056 14:43:27 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | Cycle 1(1): loaded http://localhost:55819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55819/tests/kraken/driver.html?testName=ai-astar) 14:43:28 INFO - PROCESS | 5865 | RSS: Main: 264404992 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | __start_tp_report 14:43:28 INFO - PROCESS | 5865 | _x_x_mozilla_page_load 14:43:28 INFO - PROCESS | 5865 | _x_x_mozilla_page_load_details 14:43:28 INFO - PROCESS | 5865 | |i|pagename|runs| 14:43:28 INFO - PROCESS | 5865 | |0;ai-astar;113;106;112;111;112;112;111;110;112;112 14:43:28 INFO - PROCESS | 5865 | |1;audio-beat-detection;155;131;155;216;132;166;164;137;183;142 14:43:28 INFO - PROCESS | 5865 | |2;audio-dft;165;164;162;164;161;163;162;163;163;163 14:43:28 INFO - PROCESS | 5865 | |3;audio-fft;77;81;79;148;76;77;77;78;133;76 14:43:28 INFO - PROCESS | 5865 | |4;audio-oscillator;93;94;144;94;94;96;121;93;93;118 14:43:28 INFO - PROCESS | 5865 | |5;imaging-gaussian-blur;118;117;118;118;118;125;119;117;118;118 14:43:28 INFO - PROCESS | 5865 | |6;imaging-darkroom;148;147;147;148;148;148;146;147;147;146 14:43:28 INFO - PROCESS | 5865 | |7;imaging-desaturate;96;97;97;96;96;96;98;96;95;95 14:43:28 INFO - PROCESS | 5865 | |8;json-parse-financial;57;57;58;57;57;57;56;115;54;55 14:43:28 INFO - PROCESS | 5865 | |9;json-stringify-tinderbox;59;60;60;59;60;58;59;60;61;60 14:43:28 INFO - PROCESS | 5865 | |10;stanford-crypto-aes;85;86;84;83;83;83;83;83;83;85 14:43:28 INFO - PROCESS | 5865 | |11;stanford-crypto-ccm;146;131;134;139;140;133;139;130;262;138 14:43:28 INFO - PROCESS | 5865 | |12;stanford-crypto-pbkdf2;180;173;180;178;175;179;174;173;171;173 14:43:28 INFO - PROCESS | 5865 | |13;stanford-crypto-sha256-iterative;68;69;67;68;69;66;66;68;70;66 14:43:28 INFO - PROCESS | 5865 | __end_tp_report 14:43:28 INFO - PROCESS | 5865 | __start_cc_report 14:43:28 INFO - PROCESS | 5865 | _x_x_mozilla_cycle_collect,1701 14:43:28 INFO - PROCESS | 5865 | __end_cc_report 14:43:28 INFO - PROCESS | 5865 | __startTimestamp1463089408938__endTimestamp 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | ------- Summary: start ------- 14:43:28 INFO - PROCESS | 5865 | Number of tests: 14 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:1.97 (1.8%) stddev-sans-first:1.96 14:43:28 INFO - PROCESS | 5865 | Values: 113.0 106.0 112.0 111.0 112.0 112.0 111.0 110.0 112.0 112.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:159.50 stddev:26.27 (16.5%) stddev-sans-first:27.83 14:43:28 INFO - PROCESS | 5865 | Values: 155.0 131.0 155.0 216.0 132.0 166.0 164.0 137.0 183.0 142.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.15 (0.7%) stddev-sans-first:0.97 14:43:28 INFO - PROCESS | 5865 | Values: 165.0 164.0 162.0 164.0 161.0 163.0 162.0 163.0 163.0 163.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#3] audio-fft Cycles:10 Average:90.20 Median:77.00 stddev:26.79 (34.8%) stddev-sans-first:27.98 14:43:28 INFO - PROCESS | 5865 | Values: 77.0 81.0 79.0 148.0 76.0 77.0 77.0 78.0 133.0 76.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:93.50 stddev:17.68 (18.9%) stddev-sans-first:18.29 14:43:28 INFO - PROCESS | 5865 | Values: 93.0 94.0 144.0 94.0 94.0 96.0 121.0 93.0 93.0 118.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:2.32 (2.0%) stddev-sans-first:2.45 14:43:28 INFO - PROCESS | 5865 | Values: 118.0 117.0 118.0 118.0 118.0 125.0 119.0 117.0 118.0 118.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 14:43:28 INFO - PROCESS | 5865 | Values: 148.0 147.0 147.0 148.0 148.0 148.0 146.0 147.0 147.0 146.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 14:43:28 INFO - PROCESS | 5865 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 98.0 96.0 95.0 95.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:57.00 stddev:18.55 (32.6%) stddev-sans-first:19.58 14:43:28 INFO - PROCESS | 5865 | Values: 57.0 57.0 58.0 57.0 57.0 57.0 56.0 115.0 54.0 55.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.84 (1.4%) stddev-sans-first:0.87 14:43:28 INFO - PROCESS | 5865 | Values: 59.0 60.0 60.0 59.0 60.0 58.0 59.0 60.0 61.0 60.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:1.14 (1.4%) stddev-sans-first:1.12 14:43:28 INFO - PROCESS | 5865 | Values: 85.0 86.0 84.0 83.0 83.0 83.0 83.0 83.0 83.0 85.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:139.00 stddev:39.92 (28.7%) stddev-sans-first:42.33 14:43:28 INFO - PROCESS | 5865 | Values: 146.0 131.0 134.0 139.0 140.0 133.0 139.0 130.0 262.0 138.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:176.50 stddev:3.34 (1.9%) stddev-sans-first:3.14 14:43:28 INFO - PROCESS | 5865 | Values: 180.0 173.0 180.0 178.0 175.0 179.0 174.0 173.0 171.0 173.0 14:43:28 INFO - PROCESS | 5865 | 14:43:28 INFO - PROCESS | 5865 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 14:43:28 INFO - PROCESS | 5865 | Values: 68.0 69.0 67.0 68.0 69.0 66.0 66.0 68.0 70.0 66.0 14:43:28 INFO - PROCESS | 5865 | -------- Summary: end -------- 14:43:28 INFO - PROCESS | 5865 | 14:43:29 INFO - TEST-INFO | 5865: exit 0 14:43:29 INFO - TEST-OK | kraken | took 61166ms 14:43:29 INFO - SUITE-END | took 1172s 14:43:30 INFO - Completed test suite (00:19:33) 14:43:30 INFO - javascript benchmark 14:43:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.8271445070523, 3159.763017773666, 3185.7610679199065, 3201.375731732313, 3225.5322978168165, 5171.482851714826, 5219.765110570024, 5293.99414111319, 5391.110466772982, 5447.945520544793, 5230.293910322105, 5244.082285600024, 5246.632735708502, 5250.816221432251, 5259.5529380002745, 4765.690230135039, 4793.808247670089, 4794.592459640935, 4860.9756951215195, 4965.751712414383, 4862.659613827033, 4866.513348665123, 4903.632227582928, 4907.386576677915, 4930.506949305077, 4683.742394168303, 4687.968646897677, 4694.718316900997, 4736.715797052188, 4742.881427964311, 4693.530646935314, 4781.450133234688, 4794.520547945178, 4796.640251981115, 4803.56767890888, 4687.5781179693995, 4737.526247375235, 4749.26386410107, 4756.334113224151, 4787.880302992418, 5205.973970130163, 5213.791448342062, 5225.581953443753, 5237.3453318335205, 5245.370555533323, 5589.301337332833, 5602.635828671164, 5608.298962629671, 5616.32604087508, 5630.4369563043365, 5504.862378440531, 5565.693886836222, 5585.469380408855, 5733.971330143323, 5756.222909907151, 5307.893842123174, 5308.309919710413, 5322.387925388591, 5333.986542556941, 5343.145096784496, 5774.3070831499645, 5776.191333213354, 5791.652500849878, 5822.94177058224, 5835.474807267281, 5410.1614249790555, 5554.6944918029085, 5570.303712035996, 5584.553235741131, 5587.69267690281, 5734.684592347461, 5736.397678243724, 5738.885222295531, 5745.511631511368, 5765.913511297334, 5667.866426714673, 5677.120046392815, 5679.460451257124, 5681.147827825776, 5700.458456446631, 5374.596905232123, 5563.415841336682, 5629.943700563023, 5673.687947162945, 5697.943020569741, 4325.286327755948, 4331.306990881444, 4332.436783218224, 4333.111712099075, 4367.0, 3770.377887648507, 3873.973397049784, 3874.8837534874, 3920.4511368408444, 3937.330653788863, 5043.041822053798, 5170.250313704491, 5217.06092903281, 5226.425093239741, 5229.50319719626, 5514.0, 5551.916721249185, 5561.082421400504, 5604.85987850307, 5624.268845050117, 5213.0, 5239.764210610456, 5279.656822306538, 5293.867653308698, 5298.7350632469, 4853.805847766121, 4856.854294371175, 4874.634402419832, 4900.828471003498, 4902.338184345068, 5866.413358664099, 5877.823665290048, 5888.793892213752, 5896.852578685482, 5906.734196961147, 5389.1107967186545, 5655.321361436654, 5688.402717714746, 5700.657960522382, 5703.714814259188, 5847.210626565359, 5861.706914654335, 5898.174255604133, 5910.261217347832, 5954.821355359346, 5537.529310008695, 5627.296587926509, 5633.2113504110275, 5646.604737668324, 5651.4348565143155, 5451.918221226605, 5590.86022849432, 5610.831675049755, 5626.184203290418, 5660.801871934463, 5496.120620700669, 5508.779648814003, 5509.889802204014, 5511.751971161227, 5537.8061767837935, 5461.535769459481, 5506.614536982373, 5526.91709624364, 5541.916871246854, 5619.859503512282, 5379.596530260168, 5394.406615272238, 5411.404745477916, 5430.968116057937, 5436.809711660073, 5533.142362933751, 5546.140348245867, 5546.7781288748, 5581.944180558305, 5584.581156413366, 5303.098473259633, 5397.730113494231, 5409.188621706776, 5475.863103422446, 5492.505674489155], "value": 5204.355624099834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.8072855229221, 593.2495393327439, 600.2137200267648, 605.9424354686304, 609.7500024989753, 32796.67203327966, 35671.28657426853, 35706.0, 35798.642013579854, 36911.81544092276, 45767.77116114415, 46158.0, 46467.53532464674, 46491.30263046049, 46546.534534654646, 8730.476171429718, 8816.118388161165, 8862.822743545124, 8879.978802437738, 8906.153915378061, 8729.738107856774, 8768.386212965095, 8777.078406767294, 8829.0, 8852.867206991868, 8786.824263514725, 8832.779180520507, 8836.42563233391, 8881.822363552725, 8884.644614215424, 8686.478811271343, 8755.299576033902, 8810.163034511743, 8819.691310804123, 8829.11708829112, 8626.525541095238, 8633.179847914438, 8636.82726345476, 8706.216440520384, 8718.825623487559, 40131.0, 40590.1881962362, 40637.18725625471, 40672.38991415131, 40784.38823417651, 3374.0, 3519.5072689823446, 3568.0544655666267, 3825.674817640504, 3997.200559888034, 32431.351372972407, 32493.350132997442, 32729.836350818092, 33139.2329204955, 33170.17074573131, 4222.514410842762, 4275.894151823926, 4317.0934103838235, 4331.523532411432, 4343.913121737579, 323966.0, 324775.0, 325317.3734131338, 326668.0, 327567.0, 57921.0, 57937.71031144817, 58367.0, 58522.4147758517, 58787.70606146942, 52080.0, 53340.73329633327, 56150.7192464035, 61754.69122654358, 61788.69105654533, 16048.27782749779, 16309.59226019359, 16326.265318060716, 16339.50981470534, 16390.098544579923, 12526.624201273977, 12639.810402843965, 12672.0, 12678.936605316914, 12679.873201268054, 16083.678326433639, 17569.20938557768, 17657.911710441622, 18168.273269069352, 18766.437006889813, 6648.966755166193, 6656.966715166393, 6726.452915829386, 6736.6631668416385, 6741.932580674229, 988.5057471264367, 1016.5730393234859, 1029.2023681646633, 1102.652664410708, 1124.0, 31939.680603194134, 31954.36091278208, 32013.0, 32617.0, 32744.345113097606, 1168.9532418703327, 1181.0197536045061, 1192.439553409896, 1218.7318789866215, 1255.1276862580419, 17055.914720426317, 17219.741703874453, 17324.480265592054, 17367.826321736873, 17445.30218791234, 436352.0, 437092.0, 438169.473221074, 438995.0, 439616.0, 58330.70834645884, 58335.416645833844, 58478.70760646254, 58484.0, 58558.41441585615, 1277.2528071078523, 1391.1027387335112, 1414.6675531250148, 1503.488813803312, 1592.7371983622572, 29881.252968675955, 32989.0, 33737.828912858036, 33996.830015849766, 34144.82927585346, 51199.74400127975, 51690.74154629353, 52119.0, 52492.47507524876, 52749.47250527599, 391655.0, 394720.0, 396106.0, 396269.0, 396508.0, 38291.808540957114, 43269.567304326556, 43798.56201437945, 44440.0, 44460.77769611131, 45058.09883802371, 48584.0, 48997.75501122472, 49049.5095049045, 49394.75302623464, 40165.79917100396, 41444.585554144076, 41771.98736151681, 41999.58000420079, 42153.36769948515, 41396.586034139276, 41478.170436590495, 41698.58301417068, 41705.79147104245, 42597.78701106475, 40030.39954400744, 40272.597274026884, 41350.37974430326, 41634.1673166541, 41913.79043104765, 35135.0, 36793.08017299589, 36798.63201367952, 36865.0, 37239.25521489609, 27838.582421264102, 27960.30099247454, 28150.436991259652, 28375.858120709265, 28451.573226401208], "value": 20048.885132851072, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.74096578189955, 406.6827874258078, 407.9041425265064, 416.09499338937803, 421.3700517726, 13863.722725545484, 18088.54778630533, 19804.504887377785, 19919.900400497994, 19947.50131246718, 14453.92773036136, 17668.204930778113, 17792.911035444806, 19233.32683356083, 20045.398638040882, 5559.388467268597, 5730.484256416921, 5745.971270143644, 5747.971260143693, 5757.251557297545, 5595.160725891128, 5635.690037047961, 5709.343425506057, 5735.168400581913, 5756.424357564231, 4076.510818701745, 5985.401459854023, 6313.621182729051, 6322.304546499904, 6433.8391540211405, 6241.407066328691, 6344.302126766052, 6373.0759039939185, 6408.839779005515, 6410.967945160291, 5572.60991730575, 5718.771249150071, 5720.1991721159075, 5739.110437882135, 5744.942550574483, 22191.44521386962, 22870.542589148125, 23473.178438754563, 23535.882320588287, 23721.525569488513, 2374.169040835711, 2432.3554258121612, 2522.823402361835, 2837.205582436921, 3155.1165673611426, 14374.496892608813, 14562.927185364111, 14647.487337943121, 14668.26658667073, 14931.552053438414, 1961.8626696131278, 2028.503016760903, 2064.649009668345, 2074.367317968019, 2107.3783233946024, 86988.56505717494, 89165.0, 89721.0, 89735.55132224363, 90235.54882225613, 10772.245942784086, 11082.16883733707, 11197.216194866282, 11201.103911687045, 11342.20604557673, 15522.379104835905, 15659.765103523456, 15681.13753743555, 15711.842881571038, 15745.44890928812, 8110.148434414302, 8216.630251638691, 8315.83368332642, 8414.957925210334, 8460.957695211608, 7931.127575966639, 7937.3650107991225, 7954.5624990626075, 8036.517808931483, 8057.153998830156, 6028.3971602839365, 6448.0, 6826.488013398915, 6932.272111428228, 6973.232944376216, 1907.5612609099708, 1944.9398682781414, 1987.3839109875985, 1998.230681187724, 2003.7996200379846, 948.5589201021559, 1056.0917610854658, 1065.5844220753913, 1078.3152698036804, 1119.255694962857, 19486.317978870957, 19877.0, 19982.70025949612, 19994.100265488087, 20090.598188036158, 1062.5218651606808, 1063.4629512096342, 1127.6504283672089, 1139.7549526851767, 1168.6786133813268, 11068.667939961813, 11298.265612735311, 11318.862453826885, 11459.369734664508, 11517.712057198638, 478987.0, 482205.0, 483894.0, 488761.0, 499063.0, 84511.5774421124, 84555.57722211472, 84661.15338846533, 84741.57629211814, 86362.80104699105, 1068.6526878764432, 1070.1599244593112, 1070.6734445994045, 1070.6895000449783, 1090.536521978156, 15991.760123597922, 16984.40554580584, 17107.7433838495, 17966.371177008743, 18225.635487290445, 30914.227144321572, 35471.93584192478, 36275.27449451049, 37083.443748343256, 42619.360709588764, 47588.52411475979, 49735.25397118974, 52950.4704952961, 54738.452615474926, 55803.16295255493, 8896.421732587361, 8986.236169925369, 9195.758572592615, 9273.536323183678, 9305.395149315273, 8549.786255343666, 13404.530841420503, 13536.729265414833, 13822.101563398346, 14143.292835358397, 11712.590059347882, 12099.274043557414, 12104.75790484203, 12274.631761047183, 12334.81497777516, 11989.280643161439, 12017.75964480688, 12055.276683399024, 12111.81832272499, 12339.13626046168, 11928.642140735792, 12176.33030183313, 12398.938005309916, 12399.75200496003, 12582.622521324374, 8945.0, 9108.681196158102, 9174.311926605398, 9292.442453452815, 9414.529273536158, 11394.943025285153, 11689.88310116888, 11806.173567850512, 12095.81856272139, 12172.695682607651], "value": 9564.644775883085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.647531641774, 1529.090191336155, 1566.1386237569336, 1733.904635245061, 1859.9907000464996, 7890.171531989137, 8166.183381661838, 8550.828983420335, 8740.51927144007, 8798.6920457784, 8468.957655211716, 8677.088905664908, 8718.084601116887, 8749.0, 8763.95618021909, 2061.2270398600526, 2262.1403866530695, 2322.756110608383, 2353.95292094158, 2356.257778799681, 2340.0756701103055, 2357.669926210332, 2365.2549446924163, 2365.9645105323348, 2375.3824005758543, 2295.426143464134, 2342.02805835578, 2351.870647114408, 2352.647102934565, 2354.5290941811622, 2042.28520017994, 2285.645724912641, 2356.929292121239, 2361.480474295652, 2376.942260693992, 2221.1670623516184, 2242.5963326601204, 2242.955140897173, 2243.214874793809, 2264.8980795864227, 8656.43733157349, 8703.6518539259, 8707.956460217658, 8723.084076171974, 8724.127587241224, 5181.792728290864, 5315.468453154692, 5319.0957537218765, 5321.388040375367, 5357.678539287616, 3288.901332960015, 3448.7241020718284, 3459.066052165926, 3468.2543253200683, 3531.841067151984, 1160.4545863444168, 1193.7135087579006, 1198.6583823610317, 1235.882591153839, 1242.465739731915, 12104.39478026104, 12164.0, 12173.147879648517, 12185.32980686062, 12212.572559960448, 4521.253993091169, 4554.453465584151, 4598.563136502027, 4615.330777037378, 4624.375709279271, 9655.951720241354, 9697.0, 9697.951510242403, 9716.0, 9724.902750972542, 4717.858464246078, 5254.211868219798, 5269.762860671279, 5277.313949186581, 5305.973470132624, 4671.696339737974, 4819.783109760069, 4829.154897892855, 4846.321514987904, 4853.830115945925, 3756.9436458453147, 3800.0689830991582, 3813.980930095387, 3870.3807390817333, 3920.1179734560064, 1120.2774210634095, 1122.2032357026603, 1123.3035517978906, 1127.9323240605427, 1153.8211577205548, 990.1138481059412, 995.6216637677636, 997.5760301871676, 1006.8489726541078, 1012.9949350253202, 5807.709614519342, 5850.0, 5875.471207591252, 5944.762209511658, 6071.119687645267, 453.5691093461225, 459.46013434214666, 461.73681001828635, 971.2472833554052, 1010.5856598794606, 4001.6198461146146, 4065.0853557949818, 4086.7956602169775, 4103.692223083281, 4105.753654780723, 9764.0, 9958.203343732484, 9964.501774911225, 10060.144887684628, 10071.093601575893, 9814.165795907285, 9902.009799020185, 9988.900110998797, 10112.848307275397, 10168.0, 7515.248475152441, 8282.13037631052, 8305.335573154132, 8324.958375208207, 8424.747257582283, 5750.30996280449, 5806.2451881255165, 5806.912896306474, 5881.529477641864, 5929.495992840484, 10012.799744004933, 10033.347832390871, 10095.242856785917, 10243.129334006693, 10249.077583017564, 9669.9033009669, 10223.642172523925, 10310.793784124426, 10396.220283478619, 10425.374477531372, 6485.319041500575, 7091.82270443243, 7284.635768211674, 7501.699932002659, 7630.351420129351, 8568.57157142153, 8581.227689507974, 8646.351523635627, 8671.132886711279, 8698.21716045559, 7620.80947976305, 7859.253370929752, 7901.604919754104, 7976.441649084741, 8059.314958228616, 7595.810104747205, 7625.885611715939, 7688.077430708351, 7731.265529774662, 7772.261635144652, 7015.193252775996, 7086.822829429099, 7107.395871350786, 7127.287271272831, 7146.3568278855155, 4865.5864251539015, 4948.554630083309, 5032.773525191448, 5053.242013697828, 5105.897882042264, 5085.338905942203, 5106.183010718267, 5123.052235336475, 5231.450697676842, 5289.656172348785], "value": 4543.034026596057, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.5598721661839, 342.0985702673455, 347.63324692449464, 352.70020482589786, 354.47537644286473, 5117.488251174881, 5171.7414129293575, 5172.379314482263, 5225.86935326617, 5232.064136269586, 4877.926831097528, 4975.925361119586, 5118.872028199287, 5145.224897410388, 5154.6134039946965, 4043.60495629009, 4070.633642972132, 4077.6951375559834, 4096.467459230304, 4118.258713431581, 4083.2650122977852, 4084.8978775530554, 4093.488313960755, 4108.548059713429, 4134.8139333729905, 3889.277505745975, 3973.662238709713, 4020.718549701522, 4032.9798351008203, 4093.97953010236, 4024.7383920045395, 4029.97985010076, 4032.3749818778138, 4049.088954985134, 4051.5745846686114, 3626.4197728363597, 3632.691221246197, 3632.981835090834, 3640.3265395901576, 3643.7995910224927, 4690.788914498821, 4969.478204788481, 4986.60375094974, 4993.950060499385, 5040.84877453677, 4586.449626044862, 4593.54064593538, 4607.953920460786, 4628.842789302675, 4647.442306923191, 5371.328583927009, 5372.086745253317, 5392.649477783932, 5400.351957765054, 5427.972860135714, 3831.0230891122865, 3937.232239713257, 3939.9212015759813, 3940.271049855757, 3953.9011524711823, 5537.944620553783, 5555.805546805843, 5555.833325000256, 5556.444355564411, 5587.552995760329, 3980.601939805996, 3983.900402489961, 3988.481497405319, 4003.199360127986, 4008.0, 3931.8034098295543, 4033.7378070425916, 4055.6552693020835, 4060.167665628539, 4070.5929407059057, 4482.408744895581, 4573.314002899591, 4589.311603259471, 4601.907961840744, 4625.450474091217, 5354.892902141935, 5364.275822763877, 5374.280230326258, 5425.6202065855805, 5427.348718153847, 1311.8294621699117, 1355.7898525728529, 1400.1109295597369, 1420.4105296302125, 1422.8830368160943, 881.4711173296099, 894.6689724801865, 909.60432211988, 912.4662072687552, 915.4553040940763, 4543.341215523797, 4546.522615125365, 4558.817647294071, 4615.945904072655, 4631.444226692751, 4729.266963620645, 4752.928706069411, 4783.354247176656, 4793.736344501086, 4857.805687772449, 4521.050579378301, 4555.40779698637, 4564.657650676146, 4594.1271158479785, 4617.8152873884665, 2392.2225276785116, 2531.582288922344, 2569.588865781466, 2602.596597527386, 2602.8568428736603, 4894.853154405374, 4960.677555958851, 4961.330220420269, 5007.924881126786, 5034.521720436553, 4828.609838130078, 4841.225403935354, 4864.489228630943, 4869.2939523768855, 4876.951230487721, 5258.526732594085, 5711.942880571224, 5723.742431590588, 5737.627054241461, 5741.5406767459335, 5445.537129343892, 5446.210299506629, 5466.508014278734, 5498.972505137449, 5532.861678458071, 5217.982493413748, 5451.509364157087, 5516.675997760428, 5542.445755424425, 5551.861203469945, 5724.599278050497, 5730.341010783646, 5745.052066408995, 5757.251557297524, 5762.481376676119, 4022.718409711292, 4061.005053761847, 4062.5734297899476, 4065.8576949806616, 4071.6156506787834, 5298.655587386807, 5342.675935967866, 5536.861578460571, 5619.269494965628, 5625.634333768292, 5242.97378513105, 5430.891382172414, 5438.293021907127, 5450.236966824568, 5465.59008074388, 5396.676199428047, 5427.294451721251, 5431.212474191299, 5441.80280338325, 5465.590080744039, 5263.499967503081, 5333.626646134733, 5353.652012619167, 5375.704336261543, 5376.274202982548, 5367.1680889462195, 5514.691185288794, 5517.372375149421, 5528.668279903219, 5543.1408131739645, 5312.840614781563, 5331.093714068696, 5386.43442438554, 5403.729813509387, 5410.161424979135], "value": 4048.104317116407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.9311561959423, 781.4959351218461, 788.0740130346844, 813.7029984055821, 830.236182711905, 13099.803502947452, 14808.16065796304, 14910.0, 15105.62235944102, 15233.695326093472, 13791.172529648227, 13954.930225348884, 13978.440862365518, 13990.3704333305, 13999.440022399118, 688.896665500174, 803.2369249213256, 807.2169995104739, 825.1624601029929, 827.0571548434759, 827.8096037911284, 827.9213474719892, 832.196929962586, 833.1085738260064, 834.1158372125536, 870.3254977392509, 871.3203701113142, 871.3900269811126, 873.2010210657241, 877.1447838357614, 722.238038868993, 850.4259624753298, 855.9101294364127, 866.1728049712509, 873.2839071960994, 635.8505751148523, 637.8532937424418, 637.9202599675041, 638.1162090504638, 641.2785616181795, 14322.498712545115, 14364.856351436561, 14385.71228575433, 14397.136171829723, 14445.0, 13333.200007999454, 13647.11293765912, 13724.519641812589, 13836.930815345959, 13931.0, 11884.584039558575, 12020.278783273032, 12038.4582693779, 12282.14025018249, 12352.752944941141, 4374.540673229297, 4435.135148646015, 4478.529754375776, 4566.840160594364, 4595.080983803219, 53372.46627533752, 54134.18798718022, 54544.45455545434, 54912.0, 55149.0, 10929.234953553176, 11090.279131856403, 11293.943530282297, 11346.659600212008, 11357.318560886373, 19897.403077907686, 19917.900410497856, 19965.500862478555, 20001.199952002047, 20006.799932000784, 7931.325837303893, 7972.641231144612, 8086.83826323482, 8290.8341833163, 8393.454425462325, 4604.562566556172, 4624.375709279271, 4743.0, 4792.760361981887, 4847.830325938646, 3263.3147039121577, 3327.617324007722, 3408.744344174197, 3423.8972830815114, 3425.520427140202, 686.660103248895, 691.9688614012382, 708.4509505133562, 716.7419728897593, 727.1092911183863, 591.6538824787548, 659.6553596997919, 709.3119673916293, 738.9838971414306, 740.0675149311905, 9298.0, 9858.852117218248, 9951.55218015191, 10077.647282345082, 10184.847227291597, 719.2663483247059, 725.5864157430215, 730.4229658569776, 745.3850573277068, 761.7524304601027, 4204.138151678899, 4843.39457567804, 4904.215325547895, 5142.023015627019, 5152.330197074356, 63274.0, 66660.66669666718, 67927.66036169886, 67998.0, 68403.0, 58681.70659146677, 59597.40402596005, 60109.69945150246, 60170.69914650399, 60726.0, 53208.54144480674, 54125.45874541283, 54263.72868135634, 54316.0, 54716.45283547193, 9574.281928855224, 9917.603295868374, 9994.900050999688, 10020.24848136378, 10065.194784417376, 34146.829265853514, 34461.13847153841, 35380.0, 35453.46819797757, 35748.28503429969, 43542.56457435385, 45413.545864542255, 47646.761766190946, 47799.0, 48833.0, 12406.503739850305, 12436.129470936947, 12520.686982825502, 12578.496860125859, 12585.748285034431, 14233.786493202404, 14374.425022998963, 14633.926830365781, 15016.699666006838, 15143.394264229308, 12549.874501255235, 13039.869601303866, 13626.863731362955, 13836.0, 14162.504312349018, 13126.081174317706, 13385.330733463483, 13708.725825483634, 14006.089604175697, 14105.224212668401, 12796.680082998, 13361.465541378237, 13393.665158370728, 13588.0, 13620.863791362355, 10682.252242342962, 10714.19643526723, 10745.570177192825, 10893.291936024134, 11204.327740335606, 11304.660860174208, 11328.376939268419, 11336.149788765711, 11451.255668381862, 11474.4262786862], "value": 7011.8557042229995, "unit": "score"}], "name": "dromaeo_css", "value": 7105.602065766142, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 111.0, 112.0, 112.0, 111.0, 110.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 155.0, 216.0, 132.0, 166.0, 164.0, 137.0, 183.0, 142.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 162.0, 164.0, 161.0, 163.0, 162.0, 163.0, 163.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 79.0, 148.0, 76.0, 77.0, 77.0, 78.0, 133.0, 76.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 144.0, 94.0, 94.0, 96.0, 121.0, 93.0, 93.0, 118.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 125.0, 119.0, 117.0, 118.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 148.0, 146.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 98.0, 96.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 56.0, 115.0, 54.0, 55.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 60.0, 58.0, 59.0, 60.0, 61.0, 60.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 85.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 131.0, 134.0, 139.0, 140.0, 133.0, 139.0, 130.0, 262.0, 138.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 173.0, 180.0, 178.0, 175.0, 179.0, 174.0, 173.0, 171.0, 173.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 68.0, 69.0, 66.0, 66.0, 68.0, 70.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1586.6, "alertThreshold": 2.0}]} 14:43:30 INFO - Return code: 0 14:43:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:43:30 ERROR - # TBPL SUCCESS # 14:43:30 INFO - Running post-action listener: _resource_record_post_action 14:43:30 INFO - ##### 14:43:30 INFO - ##### Finished run-tests step (success) 14:43:30 INFO - ##### 14:43:30 INFO - Running post-run listener: _resource_record_post_run 14:43:31 INFO - Total resource usage - Wall time: 1191s; CPU: 26.0%; Read bytes: 4096; Write bytes: 551043072; Read time: 20; Write time: 406132 14:43:31 INFO - TinderboxPrint: CPU usage
25.5% 14:43:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:43:31 INFO - TinderboxPrint: I/O write bytes / time
551,043,072 / 406,132 14:43:31 INFO - TinderboxPrint: CPU idle
7,077.6 (74.4%) 14:43:31 INFO - TinderboxPrint: CPU user
2,390.3 (25.1%) 14:43:31 INFO - TinderboxPrint: Swap in / out
0 / 0 14:43:31 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 251633664; Read time: 0; Write time: 233292 14:43:31 INFO - run-tests - Wall time: 1174s; CPU: 26.0%; Read bytes: 4096; Write bytes: 294924288; Read time: 20; Write time: 172276 14:43:31 INFO - Running post-run listener: _upload_blobber_files 14:43:31 INFO - Blob upload gear active. 14:43:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:31 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 14:43:31 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'] 14:43:31 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 14:43:31 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:43:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:32 INFO - (blobuploader) - INFO - Done attempting. 14:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:33 INFO - (blobuploader) - INFO - Done attempting. 14:43:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:33 INFO - Return code: 0 14:43:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cb9cce0326760ca87c75ffea9c4bd83aa88868a363cbafaddf487ee5f4a694a7abcf57dc116ed60e67d17a4d1ceb35fb6fd37eeccaebe278634f6be7a062a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adbff36b345c904a414eb4fcafe57f6e02fa2fcd52d02e24cb5febec77ed7369f4c9a44971c99c8ca7e7b3417bbc804e8138f4f01881e40a760d680534b88ceb"} 14:43:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:33 INFO - Contents: 14:43:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cb9cce0326760ca87c75ffea9c4bd83aa88868a363cbafaddf487ee5f4a694a7abcf57dc116ed60e67d17a4d1ceb35fb6fd37eeccaebe278634f6be7a062a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adbff36b345c904a414eb4fcafe57f6e02fa2fcd52d02e24cb5febec77ed7369f4c9a44971c99c8ca7e7b3417bbc804e8138f4f01881e40a760d680534b88ceb"} 14:43:33 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:33 INFO - Copying logs to upload dir... 14:43:33 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.124294 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-05-12 14:43:33.414995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 14:43:33.418995) ========= 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=00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cb9cce0326760ca87c75ffea9c4bd83aa88868a363cbafaddf487ee5f4a694a7abcf57dc116ed60e67d17a4d1ceb35fb6fd37eeccaebe278634f6be7a062a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adbff36b345c904a414eb4fcafe57f6e02fa2fcd52d02e24cb5febec77ed7369f4c9a44971c99c8ca7e7b3417bbc804e8138f4f01881e40a760d680534b88ceb"} build_url:https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005439 build_url: 'https://queue.taskcluster.net/v1/task/OAmQQ5u1T1e4EZfPJdNmbQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9cb9cce0326760ca87c75ffea9c4bd83aa88868a363cbafaddf487ee5f4a694a7abcf57dc116ed60e67d17a4d1ceb35fb6fd37eeccaebe278634f6be7a062a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/adbff36b345c904a414eb4fcafe57f6e02fa2fcd52d02e24cb5febec77ed7369f4c9a44971c99c8ca7e7b3417bbc804e8138f4f01881e40a760d680534b88ceb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-12 14:43:33.434527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:43:33.434886) ========= 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=00204705a9daa57ed339a427000001b9-1463087644.924745-1953461230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002117 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-12 14:43:33.515723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 14:43:33.516113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-12 14:43:33.516460) ========= ========= Total master_lag: 0.44 =========