builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1469447340.59 results: success (0) buildid: 20160725015528 builduid: ace9e2e55bd940b8ab9a75485d2497f7 revision: 7431edf0d97c7d93be05bd7d6b0c91474925861d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.594898) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.595417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.595854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.610968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.611457) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 04:49:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.9M=0s 2016-07-25 04:49:01 (40.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.734845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.735173) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020580 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:00.788517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 04:49:00.789375) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7431edf0d97c7d93be05bd7d6b0c91474925861d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7431edf0d97c7d93be05bd7d6b0c91474925861d --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=d6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 04:49:01,333 truncating revision to first 12 chars 2016-07-25 04:49:01,333 Setting DEBUG logging. 2016-07-25 04:49:01,333 attempt 1/10 2016-07-25 04:49:01,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7431edf0d97c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 04:49:02,378 unpacking tar archive at: mozilla-aurora-7431edf0d97c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.427641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-25 04:49:02.238474) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:02.239205) ========= script_repo_revision: 7431edf0d97c7d93be05bd7d6b0c91474925861d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:02.240477) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:02.241244) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:49:02.253597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-25 04:49:02.254352) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=d6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:02 INFO - MultiFileLogger online at 20160725 04:49:02 in /builds/slave/test 04:49:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:49:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:02 INFO - {'append_to_log': False, 04:49:02 INFO - 'base_work_dir': '/builds/slave/test', 04:49:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:49:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:02 INFO - 'branch': 'Mozilla-Aurora', 04:49:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:02 INFO - 'config_files': ('talos/linux_config.py',), 04:49:02 INFO - 'default_actions': ('clobber', 04:49:02 INFO - 'read-buildbot-config', 04:49:02 INFO - 'download-and-extract', 04:49:02 INFO - 'populate-webroot', 04:49:02 INFO - 'create-virtualenv', 04:49:02 INFO - 'install', 04:49:02 INFO - 'run-tests'), 04:49:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:02 INFO - 'download_minidump_stackwalk': True, 04:49:02 INFO - 'download_symbols': 'ondemand', 04:49:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:02 INFO - 'installer_path': 'installer.exe', 04:49:02 INFO - 'log_level': 'info', 04:49:02 INFO - 'log_name': 'talos', 04:49:02 INFO - 'log_to_console': True, 04:49:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:49:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:49:02 INFO - 'opt_config_files': (), 04:49:02 INFO - 'pip_index': False, 04:49:02 INFO - 'sps_profile': False, 04:49:02 INFO - 'sps_profile_interval': 0, 04:49:02 INFO - 'suite': 'dromaeojs-e10s', 04:49:02 INFO - 'system_bits': '32', 04:49:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:02 INFO - 'title': 'talos-linux64-ix-034', 04:49:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:02 INFO - 'use_talos_json': True, 04:49:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:02 INFO - 'work_dir': 'build'} 04:49:02 INFO - ##### 04:49:02 INFO - ##### Running clobber step. 04:49:02 INFO - ##### 04:49:02 INFO - Running pre-action listener: _resource_record_pre_action 04:49:02 INFO - Running main action method: clobber 04:49:02 INFO - rmtree: /builds/slave/test/build 04:49:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:03 INFO - Running post-action listener: _resource_record_post_action 04:49:03 INFO - ##### 04:49:03 INFO - ##### Finished clobber step (success) 04:49:03 INFO - ##### 04:49:03 INFO - ##### 04:49:03 INFO - ##### Running read-buildbot-config step. 04:49:03 INFO - ##### 04:49:03 INFO - Running pre-action listener: _resource_record_pre_action 04:49:03 INFO - Running main action method: read_buildbot_config 04:49:03 INFO - Using buildbot properties: 04:49:03 INFO - { 04:49:03 INFO - "project": "", 04:49:03 INFO - "product": "firefox", 04:49:03 INFO - "script_repo_revision": "production", 04:49:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:49:03 INFO - "repository": "", 04:49:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:49:03 INFO - "buildid": "20160725015528", 04:49:03 INFO - "pgo_build": "True", 04:49:03 INFO - "basedir": "/builds/slave/test", 04:49:03 INFO - "buildnumber": 406, 04:49:03 INFO - "slavename": "talos-linux64-ix-034", 04:49:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:49:03 INFO - "platform": "ubuntu64_hw", 04:49:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:49:03 INFO - "branch": "mozilla-aurora", 04:49:03 INFO - "repo_path": "releases/mozilla-aurora", 04:49:03 INFO - "revision": "7431edf0d97c7d93be05bd7d6b0c91474925861d", 04:49:03 INFO - "stage_platform": "linux64-pgo", 04:49:03 INFO - "builduid": "ace9e2e55bd940b8ab9a75485d2497f7", 04:49:03 INFO - "slavebuilddir": "test" 04:49:03 INFO - } 04:49:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:49:03 INFO - Running post-action listener: _resource_record_post_action 04:49:03 INFO - ##### 04:49:03 INFO - ##### Finished read-buildbot-config step (success) 04:49:03 INFO - ##### 04:49:03 INFO - ##### 04:49:03 INFO - ##### Running download-and-extract step. 04:49:03 INFO - ##### 04:49:03 INFO - Running pre-action listener: _resource_record_pre_action 04:49:03 INFO - Running main action method: download_and_extract 04:49:03 INFO - mkdir: /builds/slave/test/build/tests 04:49:03 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')]} 04:49:03 INFO - https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:49:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:49:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:49:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:49:09 INFO - Downloaded 1361 bytes. 04:49:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:49:09 INFO - Using the following test package requirements: 04:49:09 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:49:09 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:49:09 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:49:09 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'jsshell-linux-x86_64.zip'], 04:49:09 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:49:09 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:49:09 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:49:09 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:49:09 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:49:09 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:49:09 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:49:09 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:49: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')]} 04:49:09 INFO - https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:49:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:49:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:49:13 INFO - Downloaded 24494076 bytes. 04:49:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:49:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:49:14 INFO - Return code: 0 04:49:14 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:49: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')]} 04:49:14 INFO - https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:49:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:49:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:49:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:49:16 INFO - Downloaded 24494076 bytes. 04:49:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:49:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:49:17 INFO - Return code: 0 04:49:17 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')]} 04:49:17 INFO - https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:49:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:49:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:49:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:49:19 INFO - Downloaded 10833369 bytes. 04:49:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:49:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:49:19 INFO - Return code: 0 04:49: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')]} 04:49:19 INFO - https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:49:27 INFO - Downloaded 63638135 bytes. 04:49:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:49:27 INFO - mkdir: /builds/slave/test/properties 04:49:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:27 INFO - Contents: 04:49:27 INFO - build_url:https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:49:28 INFO - Running post-action listener: _resource_record_post_action 04:49:28 INFO - Running post-action listener: set_extra_try_arguments 04:49:28 INFO - ##### 04:49:28 INFO - ##### Finished download-and-extract step (success) 04:49:28 INFO - ##### 04:49:28 INFO - ##### 04:49:28 INFO - ##### Running populate-webroot step. 04:49:28 INFO - ##### 04:49:28 INFO - Running pre-action listener: _resource_record_pre_action 04:49:28 INFO - Running main action method: populate_webroot 04:49:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:28 INFO - '--tppagecycles', 04:49:28 INFO - '7'], 04:49:28 INFO - 'tests': ['tsvgm']}}, 04:49:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['damp', 'tps']}, 04:49:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'tests': ['damp', 'tps']}, 04:49:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['dromaeo_dom']}, 04:49:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['a11yr', 04:49:28 INFO - 'ts_paint', 04:49:28 INFO - 'tpaint', 04:49:28 INFO - 'sessionrestore', 04:49:28 INFO - 'sessionrestore_no_auto_restore', 04:49:28 INFO - 'tabpaint']}, 04:49:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:28 INFO - 'ts_paint', 04:49:28 INFO - 'tpaint', 04:49:28 INFO - 'sessionrestore', 04:49:28 INFO - 'sessionrestore_no_auto_restore', 04:49:28 INFO - 'tabpaint']}, 04:49:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:28 INFO - 'ts_paint', 04:49:28 INFO - 'tpaint', 04:49:28 INFO - 'sessionrestore', 04:49:28 INFO - 'sessionrestore_no_auto_restore', 04:49:28 INFO - 'tabpaint']}, 04:49:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:28 INFO - 'ts_paint', 04:49:28 INFO - 'tpaint', 04:49:28 INFO - 'sessionrestore', 04:49:28 INFO - 'sessionrestore_no_auto_restore', 04:49:28 INFO - 'tabpaint']}, 04:49:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['a11yr', 04:49:28 INFO - 'ts_paint', 04:49:28 INFO - 'tpaint', 04:49:28 INFO - 'sessionrestore', 04:49:28 INFO - 'sessionrestore_no_auto_restore', 04:49:28 INFO - 'tabpaint']}, 04:49:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['a11yr', 04:49:28 INFO - 'ts_paint', 04:49:28 INFO - 'tpaint', 04:49:28 INFO - 'sessionrestore', 04:49:28 INFO - 'sessionrestore_no_auto_restore', 04:49:28 INFO - 'tabpaint']}, 04:49:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['tsvgx', 04:49:28 INFO - 'tsvgr_opacity', 04:49:28 INFO - 'tart', 04:49:28 INFO - 'tscrollx', 04:49:28 INFO - 'cart']}, 04:49:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:28 INFO - 'tsvgr_opacity', 04:49:28 INFO - 'tart', 04:49:28 INFO - 'tscrollx', 04:49:28 INFO - 'cart']}, 04:49:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'talos_options': ['--disable-e10s'], 04:49:28 INFO - 'tests': ['tp5o']}, 04:49:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'tests': ['tp5o']}, 04:49:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'talos_options': ['--disable-e10s', 04:49:28 INFO - '--xperf_path', 04:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:28 INFO - 'tests': ['tp5n']}, 04:49:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:28 INFO - 'talos_options': ['--xperf_path', 04:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:28 INFO - 'tests': ['tp5n']}}, 04:49:28 INFO - 'talos.zip': {'path': '', 04:49:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:28 INFO - Running post-action listener: _resource_record_post_action 04:49:28 INFO - ##### 04:49:28 INFO - ##### Finished populate-webroot step (success) 04:49:28 INFO - ##### 04:49:28 INFO - ##### 04:49:28 INFO - ##### Running create-virtualenv step. 04:49:28 INFO - ##### 04:49:28 INFO - Running pre-action listener: _resource_record_pre_action 04:49:28 INFO - Running main action method: create_virtualenv 04:49:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:28 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 04:49:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:28 INFO - Using real prefix '/usr' 04:49:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:31 INFO - Installing pip.................done. 04:49:31 INFO - Return code: 0 04:49:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 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 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:31 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 04:49:31 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 04:49:31 INFO - Using env: {'DISPLAY': ':0', 04:49:31 INFO - 'HOME': '/home/cltbld', 04:49:31 INFO - 'LANG': 'en_US.UTF-8', 04:49:31 INFO - 'LANGUAGE': 'en_US:en', 04:49:31 INFO - 'LOGNAME': 'cltbld', 04:49:31 INFO - 'MAIL': '/var/mail/cltbld', 04:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:31 INFO - 'MOZ_NO_REMOTE': '1', 04:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:31 INFO - 'NO_EM_RESTART': '1', 04:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:31 INFO - 'PWD': '/builds/slave/test', 04:49:31 INFO - 'SHELL': '/bin/bash', 04:49:31 INFO - 'SHLVL': '1', 04:49:31 INFO - 'TERM': 'linux', 04:49:31 INFO - 'TMOUT': '86400', 04:49:31 INFO - 'USER': 'cltbld', 04:49:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:31 INFO - '_': '/tools/buildbot/bin/python'} 04:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:31 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 04:49:31 INFO - Cleaning up... 04:49:31 INFO - Return code: 0 04:49:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:49:31 INFO - Using env: {'DISPLAY': ':0', 04:49:31 INFO - 'HOME': '/home/cltbld', 04:49:31 INFO - 'LANG': 'en_US.UTF-8', 04:49:31 INFO - 'LANGUAGE': 'en_US:en', 04:49:31 INFO - 'LOGNAME': 'cltbld', 04:49:31 INFO - 'MAIL': '/var/mail/cltbld', 04:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:31 INFO - 'MOZ_NO_REMOTE': '1', 04:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:31 INFO - 'NO_EM_RESTART': '1', 04:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:31 INFO - 'PWD': '/builds/slave/test', 04:49:31 INFO - 'SHELL': '/bin/bash', 04:49:31 INFO - 'SHLVL': '1', 04:49:31 INFO - 'TERM': 'linux', 04:49:31 INFO - 'TMOUT': '86400', 04:49:31 INFO - 'USER': 'cltbld', 04:49:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:31 INFO - '_': '/tools/buildbot/bin/python'} 04:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:31 INFO - Downloading/unpacking psutil>=3.1.1 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:33 INFO - Installing collected packages: psutil 04:49:33 INFO - Running setup.py install for psutil 04:49:33 INFO - building 'psutil._psutil_linux' extension 04:49:33 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 04:49:33 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 04:49:33 INFO - building 'psutil._psutil_posix' extension 04:49:33 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 04:49:34 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 04:49:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:34 INFO - Successfully installed psutil 04:49:34 INFO - Cleaning up... 04:49:34 INFO - Return code: 0 04:49:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49:34 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')]} 04:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:34 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')]} 04:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:49:34 INFO - Using env: {'DISPLAY': ':0', 04:49:34 INFO - 'HOME': '/home/cltbld', 04:49:34 INFO - 'LANG': 'en_US.UTF-8', 04:49:34 INFO - 'LANGUAGE': 'en_US:en', 04:49:34 INFO - 'LOGNAME': 'cltbld', 04:49:34 INFO - 'MAIL': '/var/mail/cltbld', 04:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:34 INFO - 'MOZ_NO_REMOTE': '1', 04:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:34 INFO - 'NO_EM_RESTART': '1', 04:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:34 INFO - 'PWD': '/builds/slave/test', 04:49:34 INFO - 'SHELL': '/bin/bash', 04:49:34 INFO - 'SHLVL': '1', 04:49:34 INFO - 'TERM': 'linux', 04:49:34 INFO - 'TMOUT': '86400', 04:49:34 INFO - 'USER': 'cltbld', 04:49:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:34 INFO - '_': '/tools/buildbot/bin/python'} 04:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:34 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 04:49:34 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 04:49:34 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 04:49:34 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 04:49:34 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 04:49:34 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 04:49:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:36 INFO - Installing collected packages: mozsystemmonitor 04:49:36 INFO - Running setup.py install for mozsystemmonitor 04:49:36 INFO - Successfully installed mozsystemmonitor 04:49:36 INFO - Cleaning up... 04:49:36 INFO - Return code: 0 04:49:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:49: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 jsonschema==2.5.1 04:49:36 INFO - Using env: {'DISPLAY': ':0', 04:49:36 INFO - 'HOME': '/home/cltbld', 04:49:36 INFO - 'LANG': 'en_US.UTF-8', 04:49:36 INFO - 'LANGUAGE': 'en_US:en', 04:49:36 INFO - 'LOGNAME': 'cltbld', 04:49:36 INFO - 'MAIL': '/var/mail/cltbld', 04:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:36 INFO - 'MOZ_NO_REMOTE': '1', 04:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:36 INFO - 'NO_EM_RESTART': '1', 04:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:36 INFO - 'PWD': '/builds/slave/test', 04:49:36 INFO - 'SHELL': '/bin/bash', 04:49:36 INFO - 'SHLVL': '1', 04:49:36 INFO - 'TERM': 'linux', 04:49:36 INFO - 'TMOUT': '86400', 04:49:36 INFO - 'USER': 'cltbld', 04:49:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:36 INFO - '_': '/tools/buildbot/bin/python'} 04:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:38 INFO - warning: no files found matching '*.txt' 04:49:38 INFO - no previously-included directories found matching 'build' 04:49:38 INFO - no previously-included directories found matching 'dist' 04:49:38 INFO - no previously-included directories found matching '.git*' 04:49:38 INFO - Installing collected packages: jsonschema, functools32 04:49:38 INFO - Running setup.py install for functools32 04:49:39 INFO - warning: no files found matching '*.txt' 04:49:39 INFO - no previously-included directories found matching 'build' 04:49:39 INFO - no previously-included directories found matching 'dist' 04:49:39 INFO - no previously-included directories found matching '.git*' 04:49:39 INFO - Successfully installed jsonschema functools32 04:49:39 INFO - Cleaning up... 04:49:39 INFO - Return code: 0 04:49:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:39 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 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:39 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 04:49:39 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 04:49:39 INFO - Using env: {'DISPLAY': ':0', 04:49:39 INFO - 'HOME': '/home/cltbld', 04:49:39 INFO - 'LANG': 'en_US.UTF-8', 04:49:39 INFO - 'LANGUAGE': 'en_US:en', 04:49:39 INFO - 'LOGNAME': 'cltbld', 04:49:39 INFO - 'MAIL': '/var/mail/cltbld', 04:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:39 INFO - 'MOZ_NO_REMOTE': '1', 04:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:39 INFO - 'NO_EM_RESTART': '1', 04:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:39 INFO - 'PWD': '/builds/slave/test', 04:49:39 INFO - 'SHELL': '/bin/bash', 04:49:39 INFO - 'SHLVL': '1', 04:49:39 INFO - 'TERM': 'linux', 04:49:39 INFO - 'TMOUT': '86400', 04:49:39 INFO - 'USER': 'cltbld', 04:49:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:39 INFO - '_': '/tools/buildbot/bin/python'} 04:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 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 04:49:41 INFO - Downloading docopt-0.6.1.tar.gz 04:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:42 INFO - Running setup.py install for blobuploader 04:49:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:42 INFO - Running setup.py install for requests 04:49:42 INFO - Running setup.py install for docopt 04:49:42 INFO - Successfully installed blobuploader requests docopt 04:49:42 INFO - Cleaning up... 04:49:42 INFO - Return code: 0 04:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 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 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:42 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 04:49:42 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 04:49:42 INFO - Using env: {'DISPLAY': ':0', 04:49:42 INFO - 'HOME': '/home/cltbld', 04:49:42 INFO - 'LANG': 'en_US.UTF-8', 04:49:42 INFO - 'LANGUAGE': 'en_US:en', 04:49:42 INFO - 'LOGNAME': 'cltbld', 04:49:42 INFO - 'MAIL': '/var/mail/cltbld', 04:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:42 INFO - 'MOZ_NO_REMOTE': '1', 04:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:42 INFO - 'NO_EM_RESTART': '1', 04:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:42 INFO - 'PWD': '/builds/slave/test', 04:49:42 INFO - 'SHELL': '/bin/bash', 04:49:42 INFO - 'SHLVL': '1', 04:49:42 INFO - 'TERM': 'linux', 04:49:42 INFO - 'TMOUT': '86400', 04:49:42 INFO - 'USER': 'cltbld', 04:49:42 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:42 INFO - '_': '/tools/buildbot/bin/python'} 04:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:42 INFO - Running setup.py (path:/tmp/pip-VfHGuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:42 INFO - Running setup.py (path:/tmp/pip-d6vfXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:42 INFO - Running setup.py (path:/tmp/pip-lUemBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:43 INFO - Running setup.py (path:/tmp/pip-VqBEnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:43 INFO - Running setup.py (path:/tmp/pip-bH3FMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:43 INFO - Running setup.py (path:/tmp/pip-86PvD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:43 INFO - Running setup.py (path:/tmp/pip-5fpnYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:43 INFO - Running setup.py (path:/tmp/pip-VUQuio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:43 INFO - Running setup.py (path:/tmp/pip-RC8Mse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:43 INFO - Running setup.py (path:/tmp/pip-2vHQQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:43 INFO - Running setup.py (path:/tmp/pip-5rizGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:43 INFO - Running setup.py (path:/tmp/pip-U92gUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:43 INFO - Running setup.py (path:/tmp/pip-VqjuxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:43 INFO - Running setup.py (path:/tmp/pip-MwAAN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:43 INFO - Running setup.py (path:/tmp/pip-APvs4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:43 INFO - Running setup.py (path:/tmp/pip-ASYCUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:43 INFO - Running setup.py (path:/tmp/pip-xv9z7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:44 INFO - Running setup.py install for manifestparser 04:49:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozcrash 04:49:44 INFO - Running setup.py install for mozdebug 04:49:44 INFO - Running setup.py install for mozdevice 04:49:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozfile 04:49:44 INFO - Running setup.py install for mozhttpd 04:49:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozinfo 04:49:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozInstall 04:49:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:44 INFO - Running setup.py install for mozleak 04:49:44 INFO - Running setup.py install for mozlog 04:49:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for moznetwork 04:49:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for mozprocess 04:49:45 INFO - Running setup.py install for mozprofile 04:49:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for mozrunner 04:49:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Running setup.py install for mozscreenshot 04:49:45 INFO - Running setup.py install for moztest 04:49:45 INFO - Running setup.py install for mozversion 04:49:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:45 INFO - Cleaning up... 04:49:45 INFO - Return code: 0 04:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:45 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 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:45 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 04:49:45 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 04:49:45 INFO - Using env: {'DISPLAY': ':0', 04:49:45 INFO - 'HOME': '/home/cltbld', 04:49:45 INFO - 'LANG': 'en_US.UTF-8', 04:49:45 INFO - 'LANGUAGE': 'en_US:en', 04:49:45 INFO - 'LOGNAME': 'cltbld', 04:49:45 INFO - 'MAIL': '/var/mail/cltbld', 04:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:45 INFO - 'MOZ_NO_REMOTE': '1', 04:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:45 INFO - 'NO_EM_RESTART': '1', 04:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:45 INFO - 'PWD': '/builds/slave/test', 04:49:45 INFO - 'SHELL': '/bin/bash', 04:49:45 INFO - 'SHLVL': '1', 04:49:45 INFO - 'TERM': 'linux', 04:49:45 INFO - 'TMOUT': '86400', 04:49:45 INFO - 'USER': 'cltbld', 04:49:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:45 INFO - '_': '/tools/buildbot/bin/python'} 04:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:46 INFO - Running setup.py (path:/tmp/pip-u_uRvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:46 INFO - Running setup.py (path:/tmp/pip-nll7M9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:46 INFO - Running setup.py (path:/tmp/pip-HjmDNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:46 INFO - Running setup.py (path:/tmp/pip-YHcrAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:46 INFO - Running setup.py (path:/tmp/pip-J6HWVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:46 INFO - Running setup.py (path:/tmp/pip-e_pvjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:46 INFO - Running setup.py (path:/tmp/pip-mFlC0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:46 INFO - Running setup.py (path:/tmp/pip-auW5c6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:46 INFO - Running setup.py (path:/tmp/pip-Xhm7IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:46 INFO - Running setup.py (path:/tmp/pip-ZbifvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:46 INFO - Running setup.py (path:/tmp/pip-qyEa6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:46 INFO - Running setup.py (path:/tmp/pip-pVMO4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:46 INFO - Running setup.py (path:/tmp/pip-c6jjpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:46 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)) 04:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:46 INFO - Running setup.py (path:/tmp/pip-apHOA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:47 INFO - Running setup.py (path:/tmp/pip-pIWq42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:47 INFO - Running setup.py (path:/tmp/pip-d0B4GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:47 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)) 04:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:47 INFO - Running setup.py (path:/tmp/pip-gZWwaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:47 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)) 04:49:47 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)) 04:49:47 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)) 04:49:47 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)) 04:49:47 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)) 04:49:47 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)) 04:49:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:49 INFO - Downloading blessings-1.6.tar.gz 04:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:49 INFO - Installing collected packages: blessings 04:49:49 INFO - Running setup.py install for blessings 04:49:49 INFO - Successfully installed blessings 04:49:49 INFO - Cleaning up... 04:49:49 INFO - Return code: 0 04:49:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:49 INFO - Reading from file tmpfile_stdout 04:49:49 INFO - Current package versions: 04:49:49 INFO - argparse == 1.2.1 04:49:49 INFO - blessings == 1.6 04:49:49 INFO - blobuploader == 1.2.4 04:49:49 INFO - docopt == 0.6.1 04:49:49 INFO - functools32 == 3.2.3-2 04:49:49 INFO - jsonschema == 2.5.1 04:49:49 INFO - manifestparser == 1.1 04:49:49 INFO - mozInstall == 1.12 04:49:49 INFO - mozcrash == 0.17 04:49:49 INFO - mozdebug == 0.1 04:49:49 INFO - mozdevice == 0.48 04:49:49 INFO - mozfile == 1.2 04:49:49 INFO - mozhttpd == 0.7 04:49:49 INFO - mozinfo == 0.9 04:49:49 INFO - mozleak == 0.1 04:49:49 INFO - mozlog == 3.2 04:49:49 INFO - moznetwork == 0.27 04:49:49 INFO - mozprocess == 0.23 04:49:49 INFO - mozprofile == 0.28 04:49:49 INFO - mozrunner == 6.12 04:49:49 INFO - mozscreenshot == 0.1 04:49:49 INFO - mozsystemmonitor == 0.3 04:49:49 INFO - moztest == 0.7 04:49:49 INFO - mozversion == 1.4 04:49:49 INFO - psutil == 3.1.1 04:49:49 INFO - requests == 1.2.3 04:49:49 INFO - wsgiref == 0.1.2 04:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:49 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 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:49 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 04:49:49 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 04:49:49 INFO - Using env: {'DISPLAY': ':0', 04:49:49 INFO - 'HOME': '/home/cltbld', 04:49:49 INFO - 'LANG': 'en_US.UTF-8', 04:49:49 INFO - 'LANGUAGE': 'en_US:en', 04:49:49 INFO - 'LOGNAME': 'cltbld', 04:49:49 INFO - 'MAIL': '/var/mail/cltbld', 04:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:49 INFO - 'MOZ_NO_REMOTE': '1', 04:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:49 INFO - 'NO_EM_RESTART': '1', 04:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:49 INFO - 'PWD': '/builds/slave/test', 04:49:49 INFO - 'SHELL': '/bin/bash', 04:49:49 INFO - 'SHLVL': '1', 04:49:49 INFO - 'TERM': 'linux', 04:49:49 INFO - 'TMOUT': '86400', 04:49:49 INFO - 'USER': 'cltbld', 04:49:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:49 INFO - '_': '/tools/buildbot/bin/python'} 04:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 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)) 04:49:49 INFO - Cleaning up... 04:49:49 INFO - Return code: 0 04:49:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:49:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:49:49 INFO - Using env: {'DISPLAY': ':0', 04:49:49 INFO - 'HOME': '/home/cltbld', 04:49:49 INFO - 'LANG': 'en_US.UTF-8', 04:49:49 INFO - 'LANGUAGE': 'en_US:en', 04:49:49 INFO - 'LOGNAME': 'cltbld', 04:49:49 INFO - 'MAIL': '/var/mail/cltbld', 04:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:49 INFO - 'MOZ_NO_REMOTE': '1', 04:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:49 INFO - 'NO_EM_RESTART': '1', 04:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:49 INFO - 'PWD': '/builds/slave/test', 04:49:49 INFO - 'SHELL': '/bin/bash', 04:49:49 INFO - 'SHLVL': '1', 04:49:49 INFO - 'TERM': 'linux', 04:49:49 INFO - 'TMOUT': '86400', 04:49:49 INFO - 'USER': 'cltbld', 04:49:49 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:49 INFO - '_': '/tools/buildbot/bin/python'} 04:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:49:50 INFO - Cleaning up... 04:49:50 INFO - Return code: 0 04:49:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:49:50 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')]} 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:50 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')]} 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:50 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 0x7fdd6aad5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', '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 04:49:50 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 04:49:50 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 04:49:50 INFO - Using env: {'DISPLAY': ':0', 04:49:50 INFO - 'HOME': '/home/cltbld', 04:49:50 INFO - 'LANG': 'en_US.UTF-8', 04:49:50 INFO - 'LANGUAGE': 'en_US:en', 04:49:50 INFO - 'LOGNAME': 'cltbld', 04:49:50 INFO - 'MAIL': '/var/mail/cltbld', 04:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:50 INFO - 'MOZ_NO_REMOTE': '1', 04:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:50 INFO - 'NO_EM_RESTART': '1', 04:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:50 INFO - 'PWD': '/builds/slave/test', 04:49:50 INFO - 'SHELL': '/bin/bash', 04:49:50 INFO - 'SHLVL': '1', 04:49:50 INFO - 'TERM': 'linux', 04:49:50 INFO - 'TMOUT': '86400', 04:49:50 INFO - 'USER': 'cltbld', 04:49:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:50 INFO - '_': '/tools/buildbot/bin/python'} 04:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:50 INFO - Downloading/unpacking flake8 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:49:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:49:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:52 INFO - no previously-included directories found matching 'docs/_build' 04:49:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:49:53 INFO - Running setup.py install for pep8 04:49:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:53 INFO - no previously-included directories found matching 'docs/_build' 04:49:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:49:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:49:53 INFO - Cleaning up... 04:49:54 INFO - Return code: 0 04:49:54 INFO - Running post-action listener: _resource_record_post_action 04:49:54 INFO - Running post-action listener: _start_resource_monitoring 04:49:54 INFO - Starting resource monitoring. 04:49:54 INFO - ##### 04:49:54 INFO - ##### Finished create-virtualenv step (success) 04:49:54 INFO - ##### 04:49:54 INFO - ##### 04:49:54 INFO - ##### Running install step. 04:49:54 INFO - ##### 04:49:54 INFO - Running pre-action listener: _resource_record_pre_action 04:49:54 INFO - Running main action method: install 04:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:54 INFO - Reading from file tmpfile_stdout 04:49:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:54 INFO - Reading from file tmpfile_stdout 04:49:54 INFO - Output received: 04:49:54 INFO - Usage: mozinstall [options] installer 04:49:54 INFO - Options: 04:49:54 INFO - -h, --help show this help message and exit 04:49:54 INFO - -d DEST, --destination=DEST 04:49:54 INFO - Directory to install application into. [default: 04:49:54 INFO - "/builds/slave/test"] 04:49:54 INFO - --app=APP Application being installed. [default: firefox] 04:49:54 INFO - mkdir: /builds/slave/test/build/application 04:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:50:10 INFO - Reading from file tmpfile_stdout 04:50:10 INFO - Output received: 04:50:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:50:10 INFO - Running post-action listener: _resource_record_post_action 04:50:10 INFO - ##### 04:50:10 INFO - ##### Finished install step (success) 04:50:10 INFO - ##### 04:50:10 INFO - ##### 04:50:10 INFO - ##### Running run-tests step. 04:50:10 INFO - ##### 04:50:10 INFO - Running pre-action listener: _resource_record_pre_action 04:50:10 INFO - Running main action method: run_tests 04:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:10 INFO - Python 2.7.3 04:50:10 INFO - Return code: 0 04:50:10 INFO - grabbing minidump binary from tooltool 04:50:10 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')]} 04:50:10 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 0x197c1c0>, '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 0x197d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x197d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:10 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 04:50:10 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 04:50:10 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 04:50:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:10 INFO - Return code: 0 04:50:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:50:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:50:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:50:11 INFO - Return code: 0 04:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:50:11 INFO - Using env: {'DISPLAY': ':0', 04:50:11 INFO - 'HOME': '/home/cltbld', 04:50:11 INFO - 'LANG': 'en_US.UTF-8', 04:50:11 INFO - 'LANGUAGE': 'en_US:en', 04:50:11 INFO - 'LOGNAME': 'cltbld', 04:50:11 INFO - 'MAIL': '/var/mail/cltbld', 04:50:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:11 INFO - 'MOZ_NO_REMOTE': '1', 04:50:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:11 INFO - 'NO_EM_RESTART': '1', 04:50:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:11 INFO - 'PWD': '/builds/slave/test', 04:50:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:11 INFO - 'SHELL': '/bin/bash', 04:50:11 INFO - 'SHLVL': '1', 04:50:11 INFO - 'TERM': 'linux', 04:50:11 INFO - 'TMOUT': '86400', 04:50:11 INFO - 'USER': 'cltbld', 04:50:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679', 04:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:11 INFO - '_': '/tools/buildbot/bin/python'} 04:50:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:50:11 INFO - mozversion application_buildid: 20160725015528 04:50:11 INFO - mozversion application_changeset: 7431edf0d97c7d93be05bd7d6b0c91474925861d 04:50:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:50:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:11 INFO - mozversion application_name: Firefox 04:50:11 INFO - mozversion application_remotingname: firefox-dev 04:50:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:50:11 INFO - mozversion application_vendor: Mozilla 04:50:11 INFO - mozversion application_version: 49.0a2 04:50:11 INFO - mozversion platform_buildid: 20160725015528 04:50:11 INFO - mozversion platform_changeset: 7431edf0d97c7d93be05bd7d6b0c91474925861d 04:50:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:50:11 INFO - mozversion platform_version: 49.0a2 04:50:11 INFO - using testdate: 1469447411 04:50:11 INFO - actual date: 1469447411 04:50:11 INFO - starting webserver on 'localhost:47904' 04:50:11 INFO - SUITE-START | Running 2 tests 04:50:11 INFO - TEST-START | dromaeo_css 04:50:11 INFO - operating with platform_type : linux_ 04:50:11 INFO - Initialising browser for dromaeo_css test... 04:50:11 INFO - TEST-INFO | started process 10374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3r0nL/profile http://localhost:47904/getInfo.html) 04:50:16 INFO - PROCESS | 10374 | __metrics Screen width/height:1600/1200 04:50:16 INFO - PROCESS | 10374 | colorDepth:24 04:50:16 INFO - PROCESS | 10374 | Browser inner width/height: 1024/697 04:50:16 INFO - PROCESS | 10374 | __metrics 04:50:17 ERROR - PROCESS | 10374 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:50:17 INFO - TEST-INFO | 10374: exit 0 04:50:17 INFO - Browser initialized. 04:50:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:17 INFO - TEST-INFO | started process 10501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3r0nL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:29 INFO - PROCESS | 10501 | RSS: Main: 156192768 04:50:29 INFO - PROCESS | 10501 | 04:51:19 INFO - PROCESS | 10501 | 1469447479348 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] 04:53:27 INFO - PROCESS | 10501 | Cycle 1(1): loaded http://localhost:47904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47904/tests/dromaeo/cssquery-ext.html) 04:53:28 INFO - PROCESS | 10501 | RSS: Main: 160669696 04:53:28 INFO - PROCESS | 10501 | 04:56:30 INFO - PROCESS | 10501 | Cycle 1(1): loaded http://localhost:47904/tests/dromaeo/cssquery-ext.html (next: http://localhost:47904/tests/dromaeo/cssquery-jquery.html) 04:56:31 INFO - PROCESS | 10501 | RSS: Main: 157597696 04:56:31 INFO - PROCESS | 10501 | 04:59:32 INFO - PROCESS | 10501 | Cycle 1(1): loaded http://localhost:47904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47904/tests/dromaeo/cssquery-mootools.html) 04:59:33 INFO - PROCESS | 10501 | RSS: Main: 157802496 04:59:33 INFO - PROCESS | 10501 | 05:02:35 INFO - PROCESS | 10501 | Cycle 1(1): loaded http://localhost:47904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47904/tests/dromaeo/cssquery-prototype.html) 05:02:35 INFO - PROCESS | 10501 | RSS: Main: 156786688 05:02:35 INFO - PROCESS | 10501 | 05:05:38 INFO - PROCESS | 10501 | Cycle 1(1): loaded http://localhost:47904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47904/tests/dromaeo/cssquery-yui.html) 05:05:38 INFO - PROCESS | 10501 | RSS: Main: 158859264 05:05:38 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | Cycle 1(1): loaded http://localhost:47904/tests/dromaeo/cssquery-yui.html (next: http://localhost:47904/tests/dromaeo/cssquery-dojo.html) 05:08:41 INFO - PROCESS | 10501 | RSS: Main: 159412224 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | __start_tp_report 05:08:41 INFO - PROCESS | 10501 | _x_x_mozilla_page_load 05:08:41 INFO - PROCESS | 10501 | _x_x_mozilla_page_load_details 05:08:41 INFO - PROCESS | 10501 | |i|pagename|runs| 05:08:41 INFO - PROCESS | 10501 | |0;dojo.html;3364.7308215342773;3382.52644629752;3401.3707464119134;3425.126592718858;3427.040428679969;5649.8305050848485;5694.800681976127;5723.456271654191;5740.368559458456;5755.568332375078;5686.971565142178;5711.971440142794;5738.770449182028;5742.196092547037;5758.136279558068;5131.33292671953;5186.507281808223;5217.191335343028;5228.947710522884;5241.554467870235;5131.307273518083;5149.0731668299695;5255.789768409278;5261.526462618363;5272.340957380327;5207.3490813648295;5221.321228240324;5246.606504512158;5263.26314315996;5267.499587539178;5228.372595288571;5250.606204534656;5317.255584218213;5327.360716713981;5329.493698098674;5209.296744939423;5247.632665713401;5310.62825602208;5310.8141215057285;5321.680699158062;5442.673439593637;5517.944820551783;5559.527440167551;5561.998840208761;5642.463965923231;6123.846903827395;6147.323794382614;6147.969260153715;6148.84627884302;6157.96921015392;6045.939540604626;6216.627002379826;6226.688665566749;6227.657478838662;6246.3441338659695;5692.9146062809095;5735.053716136832;5740.6268592541355;5818.2145410369485;5835.124731290341;6301.243850737941;6316.431521163117;6320.778772742932;6329.082283069021;6332.525060620472;5842.415758424124;6011.338752737195;6069.453749162597;6078.787242446493;6091.360407157184;6126.142340072393;6226.533010024266;6241.875162496815;6249.6562689051625;6249.812505624838;6197.938020619736;6203.47270482005;6227.501799856001;6228.750849965951;6235.127082208494;6009.098635204754;6082.422169893853;6111.266648002268;6207.6275423474735;6228.128062071313;4722.338872557844;4735.479097299294;4743.359646447754;4768.451628062817;4793.0413917216;4241.151769646083;4245.044864905433;4266.381374700651;4274.1451709658195;4292.291771857671;5728.598998070095;5729.083346664514;5766.596338256281;5797.536197104221;5901.911471327933;6035.78874739382;6079.635221886612;6113.841195312599;6133.156284163852;6201.96899015502;5814.069748840166;5815.389384114692;5822.94177058224;5824.737886795105;5834.970825145847;5228.7908483660985;5306.28365170697;5358.678479291255;5367.865803354947;5383.031054410244;6296.496280297565;6310.558260921784;6336.619802811846;6339.397757213057;6347.270063942706;6055.2430946131735;6272.435480806749;6278.183836101278;6283.96858015707;6286.402791734778;6146.631202127886;6195.907061393992;6196.504279657706;6289.213848268966;6291.056341548804;6102.298235702951;6104.633721976696;6115.571909966259;6125.142480052886;6137.478314343331;6021.54838387114;6083.726232319467;6205.844853878689;6219.782307619393;6237.532185086227;5974.715436181242;6067.029275315928;6069.575129740876;6092.45167934888;6115.266168059861;5981.461668449861;5994.910076348945;6055.848603784941;6068.544859135494;6073.817785466443;5731.455511726379;5785.363610002981;5790.971045144747;5988.461038506555;5999.040153575407;5942.405759424023;5956.047032474783;5963.612365196248;5970.955082860569;6017.458428741435;5839.532837373085;5855.033919403421;5861.794837180678;5862.912056319074;5869.559783016205 05:08:41 INFO - PROCESS | 10501 | |1;ext.html;604.5103466192385;613.7054213977289;652.9804105876824;666.9695320729472;671.868985547818;46296.53703462964;47762.76118619406;47969.76015119924;52248.73875630626;52309.738451307785;48699.51300486994;49524.25713614299;49565.752171239095;49584.752076239565;49707;8767.82464350711;8872.8669069964;8899.421537600068;8916.821663566758;8921.55392230389;9111.40775849571;9148.725538233864;9202.677906273282;9204.539773011322;9218.539073046355;9237.353385263033;9263.444193348387;9272.30457715674;9273.768155796091;9279.164875161234;8856;8887.15572020657;8907.688230911952;8934.508602026886;8934.73195804127;9149.862752058725;9182.17360437564;9217.262618990464;9241;9251.398659087137;44835.77582112101;45187.096258074656;45314.54685453136;45353.773231133964;45902.54097459016;3662.157703728131;3662.212624285765;3684.613115622875;3836.5012548368813;3837.3284675182013;32787.3442531148;33017.17457063569;33085.503717444255;35495.29009419823;36485.817570911975;4251.702380833343;4269.573042695737;4282.464691913511;4316.395704601358;4332.458442694663;393445;395452;397543;398036.9999999971;398616;37795.81102094472;65739.34260657428;67104.66447667828;67332;67503.32496675069;38491.42262866059;40282.79858600747;40419.19161616751;40473;40672.38991415131;16169.514914552583;16285.59286017859;16302.755458668129;16340.83659163417;16369.508914732578;13890.097143685629;13976.88184945202;14012.789808152886;14022.509212177525;14043.71912561743;8239.299659528888;8242.052164001216;8265.876011859827;8316.958415208006;8400.243978042006;3439.3637177122314;3447.2594287541465;3471.9826400868337;3497.440409534462;3513.5608048993877;1017.2523195451338;1033.7260625934134;1073.6188653028219;1209.2442223610244;1218.4638758946212;33122.3375532488;33324.83337583345;33510.16224594356;33533.49699754506;34052.659473405445;1138.3909608359654;1160.9709757256137;1201.9038476921826;1242.1615409598485;1285.6400207941792;17527;17647.647047059243;17670.734938975926;17860.642787144185;17871.463856084338;549476;1004738;1065887;1066243;1075751;62201.68899155475;62840;63102.68448657727;63161.368386315546;63193.68403157955;1445.4290555230625;1467.4350375105876;1478.3716920308825;1481.1335368809152;1495.9177245251615;31540.526892097096;32094.19764505906;32477.188070297485;32613.18467038343;32766.83616581902;54248.18627720508;54744;55220.44779552153;55237.44762552323;55275.723621383244;417233;420745;422397;425219;425830;30440;30528.389432210788;30776.230594235323;30934.845325773225;30986.380272394876;50051.249231262285;52823.47176528339;53091.734541327045;53160;54152.458475416315;44570.77714611536;44839;44852.77573612111;45252.32121518114;46775.29837052515;43143.137137257705;44682.55317446914;44697;45079;45567.54432455633;44547.331790023825;45478.317825231985;45915;45923.31115033344;46066;37910.2417951645;38359.42460863145;38875;39928.2014359717;40081.39877901892;29727.851360743058;29984.25039374033;30016.446957312968;30249.546256805726;30415.239619009702 05:08:41 INFO - PROCESS | 10501 | |2;jquery.html;392.7074329624432;399.51059951559364;428.676349356236;428.94209281746964;430.3652113133127;16764.07797571133;17183.82816171838;18391.816081839177;18509.53726156847;20214.797852021475;12266.693332666688;12467.127301088905;12567.937160314186;16286.7556986645;17669.46991590251;5210.843674689756;5389.73051347433;5403.378611459673;5409.783608655649;5419.945800541984;5462.754176062067;5732.656040637554;5755.0504166812425;5827.796027139051;5833.679147646878;5774.220480235177;5828.708564571754;6415.903761443582;6617.735290588371;6623.437007854314;6001.159837622737;6575.375339342755;6584.242812076624;6601.900971485432;6611.074449577063;5789.681567513785;5829.970850145722;5851.707414629294;5854.326752423483;5871.1193321001765;19399.709004364944;21082.683759743617;23118.306450806504;24092.518149637086;24110.879445602834;2331;2416.0577374823833;2464.002079157926;2621.1377894006723;2751.119641714652;9946.403215807075;10604.04563589273;10889.292196007234;13361.799573006412;14102.365393557211;2030.3807338761671;2042.8263597594223;2055.393658870622;2126.723525941633;2161.481244501324;79600.60199698964;84571.57714211452;85320.57339713324;85323.99999999937;85676;10757.623483178051;10782.299150555345;10969.670909872717;10996.23026388161;11153.275037122561;14575.489857854924;14740.926295368668;14748.852511474963;14749;14869.330880110421;8229.382796290301;8400.369972252105;8446.324294056583;8458.915410845935;8468.153184681483;8182.345412366996;8350.665973360998;8365.8326833463;8403.201695838885;8488.872666910001;4344.304911214191;4345.435093437896;4476.888077798081;4484.955150448519;4504.81980720774;1929.3440230321758;1930.1700268884515;2032.400441869652;2148.409187473426;2181.5854987552316;923.8660394242797;962.7978124593774;1042.635077722806;1076.7684947736275;1079.5250089960393;17995.640087198182;18915.14881830321;19993.600127997357;20129.698054529195;20141;1065.79217052674;1073.4954571351452;1078.336822853939;1096.2381145104075;1163.5055101581963;11021.393823339633;11117.888821111685;11130.888691113147;11172.44137793107;11174.776504469864;502108;502341;509711;549421;573167;88478;88890;91665;92053.53973230091;101445.98554014514;1066.184368957748;1107.545906178479;1109.9334039957628;1114.2033446086086;1115.041064684371;18019.639607208046;18253.634927301115;18320.725189121906;18383.632327353647;18406;40885.591144088175;42044;43543.78228108966;44294.33558496561;44371.77814110909;57750;57994;63413.68293158689;63622.68188659027;63724.362756373695;6169.827732730767;8723.214910658071;8784.692535761218;8860.778480538038;8891.866622000545;12604.432800524182;13174.011949103664;13203.867961320264;14049.508267211007;14056.297185140907;12148.453319600463;12461.750764984468;12540.934020607985;12567.874321257035;12656.936715316364;11962.282263064244;12311.44598493052;12468.438920248429;12545.87454125447;12583.622491325275;12484.750304994031;12720.109592328448;12772.808407873703;12773.8083928743;12847;8855.512946787989;9090.772730681785;9157.816843663222;9277.072292770668;9328.207102396102;9370.672026479313;12393.318367489876;12521.31132787669;12680.302583358003;12699.174553653984 05:08:41 INFO - PROCESS | 10501 | |3;mootools.html;1554.6424322405842;1595.5771720494067;1781.4032299179773;1900.8099190080993;1908.8950107744085;8599.484030958147;9190.356675032743;9300.11648893354;9841.163501102406;9882.160016398606;9329.486878221694;9500.667476638318;9671.903280967188;9848.113669769718;9899.208063354932;2538.9746102538925;2546.2361291612533;2583.7287084856007;2587.4436996045847;2597.2078516052693;2532.2656429635476;2549.528337257613;2550.6429099926027;2550.681164854393;2550.872456377174;2507.047322017631;2526.835755675875;2528.506941146477;2529.4941011797714;2540.8602526861014;2439.5974664180476;2444.498877730061;2447.4737931344666;2450.3506570758764;2494.5634513959985;2480.9379765506005;2483.689538807649;2498.362917456037;2523.962140567893;2527.7093134289607;9850.753731156707;9909.157721593674;9939.204863610894;9947.55236014381;9955.75110622233;5707.115397113413;5848.619839710405;5888.646681199099;5889.734961926723;5897.764089436418;3612.331718632035;3794.772313661189;3824.1969186470874;3845.0964023454467;3890.8832735017995;1151.3437340715795;1195.8684544700077;1198.1253684810051;1217.7564487102616;1261.0290076640936;13916.721665566633;13934.721305573832;13983;14017.85982140186;14037.508687196001;4878.975605121952;4910.950890491049;5006.224035274538;5039.874003149951;5081.644284900095;10962.835557466644;10980.835287470694;11001.834972475419;11021.118310535137;11025.944870275598;5619.26949496571;5683.715814209356;5688.54491640676;5706.258186435737;5718.68547229898;4679.2045352289515;5074.695518268842;5194.3247377840635;5198.532132108128;5268.894622107537;4190.790460477025;4217.0511634881905;4261.275583150872;4270.594293542171;4312.978435107804;1228.6744012836605;1282.4421376701164;1285.736424033071;1289.3231053696884;1289.8452185737583;902.4404868981273;1092.4592326798286;1096.4627332606965;1101.2755279849357;1133.8525991621202;6490.318516555788;6650.9667451662435;6699.464042876558;6763.256041835394;6780.660966951731;1003.0922015575916;1013.2198207380276;1025.1849779425374;1082.2099867097063;1086.473060565625;4625.098105869323;4723.976380118146;4735;4760.809567617326;4771.95228047715;12269.141160118706;12381;12531.621521632613;12650.557230496888;12668.746625067632;12425.316607586488;12557.309347985765;12595.24428534291;12595.433205505775;12631.305278209604;8754.430961987451;8864.778380540538;8903.465792052497;8962.283017358595;9117.088291170963;6666.600003999775;6671;6702.530822842355;6828.453723702191;6859.725610975505;11221.831672525082;11389.031932285849;11399.145064120059;11558.30650160993;11596.188266821242;11606.593769218036;11719.355435451133;11734.530618775154;11740.530378784753;11885.5840045598;8088.9595552021865;8116.350691944748;8120.796980075545;8140.674373025249;8142.796430089295;9401.905980940102;9479.241660667269;9502.239820814457;9528.047195280416;9528.475933823429;8181.550014749246;8257.133001035045;8621.482711037357;8673.956630216808;8749.518776467356;8346.874796878174;8418.957905210435;8423.452475589067;8439.493630382196;8466.365022623451;8079.434439589172;8139.308158806568;8167.550784706898;8168.632411541614;8200.179982001991;5718.1708652246025;5868.471837534642;5883.0881213411985;5986.2217911671205;5995.730192141277;5957.927573036895;6026.7287972040485;6037.818865434044;6104.9389506106145;6114.021756519113 05:08:41 INFO - PROCESS | 10501 | |4;prototype.html;323.8235161836799;326.5591451540419;328.99013029609114;337.8006975884228;340.0953463786329;5708.486236238738;5751.009475072965;5778.428599273325;5826.650400975945;5836.562257830664;5617.21359009739;5655.784006438615;5683.943160568393;5689.4879460848515;5708.316046766204;4352.847650332239;4398.362237475564;4433.600975912167;4458.595542404132;4471.19518486673;4349.826006959718;4386.934195987063;4398.64810815134;4404.163208990298;4410.272305069676;4340.218760623086;4356.803943822536;4385.6710746694125;4408.669349798778;4444.422225110731;4170.833166673329;4243.893902652443;4308.612224899774;4320.870373888788;4345.521992580813;3784.2620688965662;3805.429185622151;3811.161544460242;3831.9042023949346;3865.845366185349;5441.782328706847;5457.263269458612;5467.972660136674;5521.751521181516;5531.778728850841;4919.26211068339;4994.87512812179;5028.5977121830165;5041.445441001487;5097.923531147036;5952.1964534787685;5981.8803623927715;5995.280566332024;6005.549583781234;6021.488173505258;4228.71796406887;4231.42875711778;4277.636400905927;4283.907603561072;4306.6554675626185;6098.115773212904;6104.26748790148;6110.29731580865;6152.2924863640355;6176.84557886052;4352.760598167131;4374.300111982067;4399.274119770266;4400;4413.205622987829;4348.543402942709;4442.244818380883;4442.666799990014;4447.3773671685985;4449.154660614473;4964.975175124174;5010.348654674942;5021.447640759587;5036.949630503721;5040.621953353513;5898.203742494794;5960.940390596125;5972.372900845436;5992.64044157352;6082.209312789398;1494.8430414806505;1533.3789815124892;1540.4762380790585;1557.9298931548108;1560.867326277279;957.5116690487902;969.3553786731885;984.5077461269366;990.153418826907;990.9495934309655;5023.397192336943;5056.710538812579;5073.057626576577;5083.161278389099;5127.53852153308;5384.78460861569;5464.535514481314;5509;5520.267467603562;5581.023320918823;5124.590032797368;5497.587680923947;5774.740136693775;5784.074548072373;5805.506531944832;3319.27397753167;3330.733541316689;3369.730421566269;3372.662733726657;3373.915652108717;6003.699815009232;6225.3774622538285;6244.937550624527;6278.434940855345;6303.243610766737;6277.089821975788;6290.276618188876;6300.30696623371;6305.274893387319;6331.96834015827;6086.6652334122045;6235.532335074888;6243.594166379171;6254.249490061131;6284;6089;6160.599561028698;6179.3820617937845;6264.404881536247;6264.5301602379095;6020.849478763066;6037.09443583466;6038.403486500847;6062.514998800174;6088.939110608837;6030.85413771382;6163.876722465615;6233.719482623384;6253.1245625613365;6281.685915704105;4299.140171965682;4304.4834619845815;4328.567143285646;4339.1972485090355;4351.803254105146;5947.940520594739;6276.372362763687;6289.245290564979;6313.494920406449;6316.968415157895;6020.819375418744;6047.818565443044;6054.243219597551;6074.90887636677;6081.817545473643;6054.759738896636;6062.484688801501;6074.90887636677;6114.877702446015;6119.388061194023;5664.461876121762;5930.733117009659;5944.256967879015;5950.910736338872;5990.903183885605;5969.91045134332;6040.7347244783205;6073.993373280078;6095.908561371672;6105.236845394325;5697.4302569742695;5782.624129431573;5920.319163296276;5927.881442371215;5997.570983751588 05:08:41 INFO - PROCESS | 10501 | |5;yui.html;773.8336257704595;777.024833833539;779.1624004195484;811.991880081199;817.7342363731786;15488.612784680388;16766.245518951648;16774.58063548412;16801.747973780373;16966.660666786673;15401;15680.215989200522;15739.134347610876;15744.763828542553;16701.164941752926;838.995805020974;845.995770021149;848.2916764501648;848.9320854331638;849.9830003399928;855.0807881527352;855.8844555984956;856.6787454704486;860.109786371106;862.9439086459391;900.9639614415415;909.068205089785;910.1444642036464;912.803747194353;916.8533034714447;892.8883889513811;897.8114595934796;899.9955000225023;902.1024081039375;902.9413088149249;661.8874791285493;662.4634046422414;662.867426514699;663.1677245057471;664.5713514782938;16573.4199303025;16668.33326666932;16771.413000544922;16783.748243776354;16804.075775832323;14659.34032968519;14996.25018749069;15316.846831531653;15650.68698626021;15695.450659226986;12330.260184388966;12434.689132771662;12841.165324253894;12897.484100635964;13280.07039507235;3984.880453586397;4078;4138.586141385837;4140;4177.289860723654;67690.66154669244;70887.2911270891;71435.92846107365;76846.61576692137;80355;12385.442655080544;12616;12703.428345724464;12806;12978.156419832869;22469.213577524708;22497.212597559006;22656.773432265796;22676.88661556682;22684.092636294692;9412.717618471457;9449.244060475145;9574.808503829885;9705.514724263758;9815.852762208573;5109.616778741609;5235.528802407725;5235.712035837989;5295.338082739658;5349.545288650431;3999.680025597945;4068.1253530491085;4116.958830411658;4127.277726397869;4142.482189726285;716.8888822232562;723.1502983993892;737.498501019312;741.5624781379013;744.4528271720282;622.3838399983983;724.5326764237037;724.731849215783;724.9601271930095;732.3372348025046;10166.847497287547;10281.948590257001;10311.175105991502;10502.212334074975;10554.577816887391;723.5224751663876;737.3189128786375;738.5273425007999;739.8187444076236;760.69572171132;4610.008848097675;4674.018456124184;4696.5303469653445;4708.246680531099;4739.644526660514;71567.6421617899;71997.64001179961;115295;117054;120066;62104.689476552325;64490.35509644844;67138;87840.5607971956;101693;75680.62159689167;83182;84060.73908891372;84947.5752621233;85675.57162214149;9568.521573921136;9696.272779541421;9705.466199359103;9860;10100.646477373257;47794;49037;51231;52493;53223.4677653234;67820.6608966952;76559.8516022249;76768.84846727415;76926;77053.61473192598;13017.869821302045;13068.54260100892;13275.700540803156;13790.724185516434;13965.650858728613;15177.6205594861;15414.306356213772;15627.921860390625;15849.52451426459;16473.423430179886;13740.587782366545;13747.312634368442;13797.724045519235;13882;14728.484503042342;13683.794743079061;13788.820492947743;13852.584422467342;13969.790453143414;14397.064190827563;14122.929385353007;14212.857871421153;14366.3535140921;14596.270186490845;15314.770278445609;11603.709907252387;11776.4700588472;11945.82081268799;12016.158868879444;12222.755544888874;12235.93882030584;12329.568465103679;12485.937570312453;12668.366581670694;12780.61658150257 05:08:41 INFO - PROCESS | 10501 | __end_tp_report 05:08:41 INFO - PROCESS | 10501 | __start_cc_report 05:08:41 INFO - PROCESS | 10501 | _x_x_mozilla_cycle_collect,332 05:08:41 INFO - PROCESS | 10501 | __end_cc_report 05:08:41 INFO - PROCESS | 10501 | __startTimestamp1469448521407__endTimestamp 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | ------- Summary: start ------- 05:08:41 INFO - PROCESS | 10501 | Number of tests: 6 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | [#0] dojo.html Cycles:165 Average:5712.89 Median:5869.56 stddev:631.53 (10.8%) stddev-sans-first:606.00 05:08:41 INFO - PROCESS | 10501 | Values: 3364.7 3382.5 3401.4 3425.1 3427.0 5649.8 5694.8 5723.5 5740.4 5755.6 5687.0 5712.0 5738.8 5742.2 5758.1 5131.3 5186.5 5217.2 5228.9 5241.6 5131.3 5149.1 5255.8 5261.5 5272.3 5207.3 5221.3 5246.6 5263.3 5267.5 5228.4 5250.6 5317.3 5327.4 5329.5 5209.3 5247.6 5310.6 5310.8 5321.7 5442.7 5517.9 5559.5 5562.0 5642.5 6123.8 6147.3 6148.0 6148.8 6158.0 6045.9 6216.6 6226.7 6227.7 6246.3 5692.9 5735.1 5740.6 5818.2 5835.1 6301.2 6316.4 6320.8 6329.1 6332.5 5842.4 6011.3 6069.5 6078.8 6091.4 6126.1 6226.5 6241.9 6249.7 6249.8 6197.9 6203.5 6227.5 6228.8 6235.1 6009.1 6082.4 6111.3 6207.6 6228.1 4722.3 4735.5 4743.4 4768.5 4793.0 4241.2 4245.0 4266.4 4274.1 4292.3 5728.6 5729.1 5766.6 5797.5 5901.9 6035.8 6079.6 6113.8 6133.2 6202.0 5814.1 5815.4 5822.9 5824.7 5835.0 5228.8 5306.3 5358.7 5367.9 5383.0 6296.5 6310.6 6336.6 6339.4 6347.3 6055.2 6272.4 6278.2 6284.0 6286.4 6146.6 6195.9 6196.5 6289.2 6291.1 6102.3 6104.6 6115.6 6125.1 6137.5 6021.5 6083.7 6205.8 6219.8 6237.5 5974.7 6067.0 6069.6 6092.5 6115.3 5981.5 5994.9 6055.8 6068.5 6073.8 5731.5 5785.4 5791.0 5988.5 5999.0 5942.4 5956.0 5963.6 5971.0 6017.5 5839.5 5855.0 5861.8 5862.9 5869.6 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | [#1] ext.html Cycles:180 Average:73333.19 Median:215049.79 stddev:177401.42 (82.5%) stddev-sans-first:177815.04 05:08:41 INFO - PROCESS | 10501 | Values: 604.5 613.7 653.0 667.0 671.9 46296.5 47762.8 47969.8 52248.7 52309.7 48699.5 49524.3 49565.8 49584.8 49707.0 8767.8 8872.9 8899.4 8916.8 8921.6 9111.4 9148.7 9202.7 9204.5 9218.5 9237.4 9263.4 9272.3 9273.8 9279.2 8856.0 8887.2 8907.7 8934.5 8934.7 9149.9 9182.2 9217.3 9241.0 9251.4 44835.8 45187.1 45314.5 45353.8 45902.5 3662.2 3662.2 3684.6 3836.5 3837.3 32787.3 33017.2 33085.5 35495.3 36485.8 4251.7 4269.6 4282.5 4316.4 4332.5 393445.0 395452.0 397543.0 398037.0 398616.0 37795.8 65739.3 67104.7 67332.0 67503.3 38491.4 40282.8 40419.2 40473.0 40672.4 16169.5 16285.6 16302.8 16340.8 16369.5 13890.1 13976.9 14012.8 14022.5 14043.7 8239.3 8242.1 8265.9 8317.0 8400.2 3439.4 3447.3 3472.0 3497.4 3513.6 1017.3 1033.7 1073.6 1209.2 1218.5 33122.3 33324.8 33510.2 33533.5 34052.7 1138.4 1161.0 1201.9 1242.2 1285.6 17527.0 17647.6 17670.7 17860.6 17871.5 549476.0 1004738.0 1065887.0 1066243.0 1075751.0 62201.7 62840.0 63102.7 63161.4 63193.7 1445.4 1467.4 1478.4 1481.1 1495.9 31540.5 32094.2 32477.2 32613.2 32766.8 54248.2 54744.0 55220.4 55237.4 55275.7 417233.0 420745.0 422397.0 425219.0 425830.0 30440.0 30528.4 30776.2 30934.8 30986.4 50051.2 52823.5 53091.7 53160.0 54152.5 44570.8 44839.0 44852.8 45252.3 46775.3 43143.1 44682.6 44697.0 45079.0 45567.5 44547.3 45478.3 45915.0 45923.3 46066.0 37910.2 38359.4 38875.0 39928.2 40081.4 29727.9 29984.3 30016.4 30249.5 30415.2 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | [#2] jquery.html Cycles:180 Average:30301.72 Median:13211.76 stddev:86974.91 (658.3%) stddev-sans-first:87189.90 05:08:41 INFO - PROCESS | 10501 | Values: 392.7 399.5 428.7 428.9 430.4 16764.1 17183.8 18391.8 18509.5 20214.8 12266.7 12467.1 12567.9 16286.8 17669.5 5210.8 5389.7 5403.4 5409.8 5419.9 5462.8 5732.7 5755.1 5827.8 5833.7 5774.2 5828.7 6415.9 6617.7 6623.4 6001.2 6575.4 6584.2 6601.9 6611.1 5789.7 5830.0 5851.7 5854.3 5871.1 19399.7 21082.7 23118.3 24092.5 24110.9 2331.0 2416.1 2464.0 2621.1 2751.1 9946.4 10604.0 10889.3 13361.8 14102.4 2030.4 2042.8 2055.4 2126.7 2161.5 79600.6 84571.6 85320.6 85324.0 85676.0 10757.6 10782.3 10969.7 10996.2 11153.3 14575.5 14740.9 14748.9 14749.0 14869.3 8229.4 8400.4 8446.3 8458.9 8468.2 8182.3 8350.7 8365.8 8403.2 8488.9 4344.3 4345.4 4476.9 4485.0 4504.8 1929.3 1930.2 2032.4 2148.4 2181.6 923.9 962.8 1042.6 1076.8 1079.5 17995.6 18915.1 19993.6 20129.7 20141.0 1065.8 1073.5 1078.3 1096.2 1163.5 11021.4 11117.9 11130.9 11172.4 11174.8 502108.0 502341.0 509711.0 549421.0 573167.0 88478.0 88890.0 91665.0 92053.5 101446.0 1066.2 1107.5 1109.9 1114.2 1115.0 18019.6 18253.6 18320.7 18383.6 18406.0 40885.6 42044.0 43543.8 44294.3 44371.8 57750.0 57994.0 63413.7 63622.7 63724.4 6169.8 8723.2 8784.7 8860.8 8891.9 12604.4 13174.0 13203.9 14049.5 14056.3 12148.5 12461.8 12540.9 12567.9 12656.9 11962.3 12311.4 12468.4 12545.9 12583.6 12484.8 12720.1 12772.8 12773.8 12847.0 8855.5 9090.8 9157.8 9277.1 9328.2 9370.7 12393.3 12521.3 12680.3 12699.2 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | [#3] mootools.html Cycles:180 Average:6455.58 Median:4701.59 stddev:3725.18 (79.2%) stddev-sans-first:3717.42 05:08:41 INFO - PROCESS | 10501 | Values: 1554.6 1595.6 1781.4 1900.8 1908.9 8599.5 9190.4 9300.1 9841.2 9882.2 9329.5 9500.7 9671.9 9848.1 9899.2 2539.0 2546.2 2583.7 2587.4 2597.2 2532.3 2549.5 2550.6 2550.7 2550.9 2507.0 2526.8 2528.5 2529.5 2540.9 2439.6 2444.5 2447.5 2450.4 2494.6 2480.9 2483.7 2498.4 2524.0 2527.7 9850.8 9909.2 9939.2 9947.6 9955.8 5707.1 5848.6 5888.6 5889.7 5897.8 3612.3 3794.8 3824.2 3845.1 3890.9 1151.3 1195.9 1198.1 1217.8 1261.0 13916.7 13934.7 13983.0 14017.9 14037.5 4879.0 4911.0 5006.2 5039.9 5081.6 10962.8 10980.8 11001.8 11021.1 11025.9 5619.3 5683.7 5688.5 5706.3 5718.7 4679.2 5074.7 5194.3 5198.5 5268.9 4190.8 4217.1 4261.3 4270.6 4313.0 1228.7 1282.4 1285.7 1289.3 1289.8 902.4 1092.5 1096.5 1101.3 1133.9 6490.3 6651.0 6699.5 6763.3 6780.7 1003.1 1013.2 1025.2 1082.2 1086.5 4625.1 4724.0 4735.0 4760.8 4772.0 12269.1 12381.0 12531.6 12650.6 12668.7 12425.3 12557.3 12595.2 12595.4 12631.3 8754.4 8864.8 8903.5 8962.3 9117.1 6666.6 6671.0 6702.5 6828.5 6859.7 11221.8 11389.0 11399.1 11558.3 11596.2 11606.6 11719.4 11734.5 11740.5 11885.6 8089.0 8116.4 8120.8 8140.7 8142.8 9401.9 9479.2 9502.2 9528.0 9528.5 8181.6 8257.1 8621.5 8674.0 8749.5 8346.9 8419.0 8423.5 8439.5 8466.4 8079.4 8139.3 8167.6 8168.6 8200.2 5718.2 5868.5 5883.1 5986.2 5995.7 5957.9 6026.7 6037.8 6104.9 6114.0 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | [#4] prototype.html Cycles:180 Average:4985.76 Median:5686.72 stddev:1473.40 (25.9%) stddev-sans-first:1435.38 05:08:41 INFO - PROCESS | 10501 | Values: 323.8 326.6 329.0 337.8 340.1 5708.5 5751.0 5778.4 5826.7 5836.6 5617.2 5655.8 5683.9 5689.5 5708.3 4352.8 4398.4 4433.6 4458.6 4471.2 4349.8 4386.9 4398.6 4404.2 4410.3 4340.2 4356.8 4385.7 4408.7 4444.4 4170.8 4243.9 4308.6 4320.9 4345.5 3784.3 3805.4 3811.2 3831.9 3865.8 5441.8 5457.3 5468.0 5521.8 5531.8 4919.3 4994.9 5028.6 5041.4 5097.9 5952.2 5981.9 5995.3 6005.5 6021.5 4228.7 4231.4 4277.6 4283.9 4306.7 6098.1 6104.3 6110.3 6152.3 6176.8 4352.8 4374.3 4399.3 4400.0 4413.2 4348.5 4442.2 4442.7 4447.4 4449.2 4965.0 5010.3 5021.4 5036.9 5040.6 5898.2 5960.9 5972.4 5992.6 6082.2 1494.8 1533.4 1540.5 1557.9 1560.9 957.5 969.4 984.5 990.2 990.9 5023.4 5056.7 5073.1 5083.2 5127.5 5384.8 5464.5 5509.0 5520.3 5581.0 5124.6 5497.6 5774.7 5784.1 5805.5 3319.3 3330.7 3369.7 3372.7 3373.9 6003.7 6225.4 6244.9 6278.4 6303.2 6277.1 6290.3 6300.3 6305.3 6332.0 6086.7 6235.5 6243.6 6254.2 6284.0 6089.0 6160.6 6179.4 6264.4 6264.5 6020.8 6037.1 6038.4 6062.5 6088.9 6030.9 6163.9 6233.7 6253.1 6281.7 4299.1 4304.5 4328.6 4339.2 4351.8 5947.9 6276.4 6289.2 6313.5 6317.0 6020.8 6047.8 6054.2 6074.9 6081.8 6054.8 6062.5 6074.9 6114.9 6119.4 5664.5 5930.7 5944.3 5950.9 5990.9 5969.9 6040.7 6074.0 6095.9 6105.2 5697.4 5782.6 5920.3 5927.9 5997.6 05:08:41 INFO - PROCESS | 10501 | 05:08:41 INFO - PROCESS | 10501 | [#5] yui.html Cycles:180 Average:20034.19 Median:4642.01 stddev:26993.07 (581.5%) stddev-sans-first:27030.05 05:08:41 INFO - PROCESS | 10501 | Values: 773.8 777.0 779.2 812.0 817.7 15488.6 16766.2 16774.6 16801.7 16966.7 15401.0 15680.2 15739.1 15744.8 16701.2 839.0 846.0 848.3 848.9 850.0 855.1 855.9 856.7 860.1 862.9 901.0 909.1 910.1 912.8 916.9 892.9 897.8 900.0 902.1 902.9 661.9 662.5 662.9 663.2 664.6 16573.4 16668.3 16771.4 16783.7 16804.1 14659.3 14996.3 15316.8 15650.7 15695.5 12330.3 12434.7 12841.2 12897.5 13280.1 3984.9 4078.0 4138.6 4140.0 4177.3 67690.7 70887.3 71435.9 76846.6 80355.0 12385.4 12616.0 12703.4 12806.0 12978.2 22469.2 22497.2 22656.8 22676.9 22684.1 9412.7 9449.2 9574.8 9705.5 9815.9 5109.6 5235.5 5235.7 5295.3 5349.5 3999.7 4068.1 4117.0 4127.3 4142.5 716.9 723.2 737.5 741.6 744.5 622.4 724.5 724.7 725.0 732.3 10166.8 10281.9 10311.2 10502.2 10554.6 723.5 737.3 738.5 739.8 760.7 4610.0 4674.0 4696.5 4708.2 4739.6 71567.6 71997.6 115295.0 117054.0 120066.0 62104.7 64490.4 67138.0 87840.6 101693.0 75680.6 83182.0 84060.7 84947.6 85675.6 9568.5 9696.3 9705.5 9860.0 10100.6 47794.0 49037.0 51231.0 52493.0 53223.5 67820.7 76559.9 76768.8 76926.0 77053.6 13017.9 13068.5 13275.7 13790.7 13965.7 15177.6 15414.3 15627.9 15849.5 16473.4 13740.6 13747.3 13797.7 13882.0 14728.5 13683.8 13788.8 13852.6 13969.8 14397.1 14122.9 14212.9 14366.4 14596.3 15314.8 11603.7 11776.5 11945.8 12016.2 12222.8 12235.9 12329.6 12485.9 12668.4 12780.6 05:08:41 INFO - PROCESS | 10501 | -------- Summary: end -------- 05:08:41 INFO - PROCESS | 10501 | 05:08:42 INFO - TEST-INFO | 10501: exit 0 05:08:42 INFO - TEST-OK | dromaeo_css | took 1110396ms 05:08:42 INFO - TEST-START | kraken 05:08:42 INFO - operating with platform_type : linux_ 05:08:42 INFO - Initialising browser for kraken test... 05:08:42 INFO - TEST-INFO | started process 10744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMktg0/profile http://localhost:47904/getInfo.html) 05:08:46 INFO - PROCESS | 10744 | __metrics Screen width/height:1600/1200 05:08:46 INFO - PROCESS | 10744 | colorDepth:24 05:08:46 INFO - PROCESS | 10744 | Browser inner width/height: 1024/697 05:08:46 INFO - PROCESS | 10744 | __metrics 05:08:47 ERROR - PROCESS | 10744 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:08:48 INFO - TEST-INFO | 10744: exit 0 05:08:48 INFO - Browser initialized. 05:08:48 INFO - Running cycle 1/1 for kraken test... 05:08:48 INFO - TEST-INFO | started process 10872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaMktg0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:00 INFO - PROCESS | 10872 | RSS: Main: 156278784 05:09:00 INFO - PROCESS | 10872 | 05:09:02 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47904/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:03 INFO - PROCESS | 10872 | RSS: Main: 161378304 05:09:03 INFO - PROCESS | 10872 | 05:09:06 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47904/tests/kraken/driver.html?testName=audio-dft) 05:09:06 INFO - PROCESS | 10872 | RSS: Main: 160419840 05:09:06 INFO - PROCESS | 10872 | 05:09:09 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47904/tests/kraken/driver.html?testName=audio-fft) 05:09:10 INFO - PROCESS | 10872 | RSS: Main: 161255424 05:09:10 INFO - PROCESS | 10872 | 05:09:12 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47904/tests/kraken/driver.html?testName=audio-oscillator) 05:09:12 INFO - PROCESS | 10872 | RSS: Main: 161406976 05:09:12 INFO - PROCESS | 10872 | 05:09:15 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:15 INFO - PROCESS | 10872 | RSS: Main: 160968704 05:09:15 INFO - PROCESS | 10872 | 05:09:18 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47904/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:19 INFO - PROCESS | 10872 | RSS: Main: 160858112 05:09:19 INFO - PROCESS | 10872 | 05:09:22 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47904/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:23 INFO - PROCESS | 10872 | RSS: Main: 161579008 05:09:23 INFO - PROCESS | 10872 | 05:09:26 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47904/tests/kraken/driver.html?testName=json-parse-financial) 05:09:26 INFO - PROCESS | 10872 | RSS: Main: 160952320 05:09:26 INFO - PROCESS | 10872 | 05:09:28 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:28 INFO - PROCESS | 10872 | RSS: Main: 160878592 05:09:28 INFO - PROCESS | 10872 | 05:09:30 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:31 INFO - PROCESS | 10872 | RSS: Main: 161136640 05:09:31 INFO - PROCESS | 10872 | 05:09:33 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:34 INFO - PROCESS | 10872 | RSS: Main: 161820672 05:09:34 INFO - PROCESS | 10872 | 05:09:36 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:37 INFO - PROCESS | 10872 | RSS: Main: 162115584 05:09:37 INFO - PROCESS | 10872 | 05:09:39 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:40 INFO - PROCESS | 10872 | RSS: Main: 161890304 05:09:40 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | Cycle 1(1): loaded http://localhost:47904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47904/tests/kraken/driver.html?testName=ai-astar) 05:09:42 INFO - PROCESS | 10872 | RSS: Main: 162127872 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | __start_tp_report 05:09:42 INFO - PROCESS | 10872 | _x_x_mozilla_page_load 05:09:42 INFO - PROCESS | 10872 | _x_x_mozilla_page_load_details 05:09:42 INFO - PROCESS | 10872 | |i|pagename|runs| 05:09:42 INFO - PROCESS | 10872 | |0;ai-astar;113;104;113;109;110;112;112;113;111;111 05:09:42 INFO - PROCESS | 10872 | |1;audio-beat-detection;154;133;158;178;126;150;156;127;173;126 05:09:42 INFO - PROCESS | 10872 | |2;audio-dft;164;163;161;163;165;162;163;161;161;161 05:09:42 INFO - PROCESS | 10872 | |3;audio-fft;75;75;76;176;75;76;74;77;163;77 05:09:42 INFO - PROCESS | 10872 | |4;audio-oscillator;84;85;146;85;84;85;135;85;85;145 05:09:42 INFO - PROCESS | 10872 | |5;imaging-gaussian-blur;118;117;118;118;118;117;117;116;118;118 05:09:42 INFO - PROCESS | 10872 | |6;imaging-darkroom;147;148;147;147;146;147;147;147;147;147 05:09:42 INFO - PROCESS | 10872 | |7;imaging-desaturate;96;95;97;94;95;95;95;96;96;95 05:09:42 INFO - PROCESS | 10872 | |8;json-parse-financial;50;51;55;52;50;52;53;52;51;54 05:09:42 INFO - PROCESS | 10872 | |9;json-stringify-tinderbox;59;63;59;60;62;59;60;59;66;59 05:09:42 INFO - PROCESS | 10872 | |10;stanford-crypto-aes;80;76;78;77;79;77;84;78;99;77 05:09:42 INFO - PROCESS | 10872 | |11;stanford-crypto-ccm;130;129;126;119;127;123;123;130;124;129 05:09:42 INFO - PROCESS | 10872 | |12;stanford-crypto-pbkdf2;155;154;160;156;151;152;156;155;157;153 05:09:42 INFO - PROCESS | 10872 | |13;stanford-crypto-sha256-iterative;63;62;66;63;60;63;62;61;63;61 05:09:42 INFO - PROCESS | 10872 | __end_tp_report 05:09:42 INFO - PROCESS | 10872 | __start_cc_report 05:09:42 INFO - PROCESS | 10872 | _x_x_mozilla_cycle_collect,883 05:09:42 INFO - PROCESS | 10872 | __end_cc_report 05:09:42 INFO - PROCESS | 10872 | __startTimestamp1469448582440__endTimestamp 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | ------- Summary: start ------- 05:09:42 INFO - PROCESS | 10872 | Number of tests: 14 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.74 (2.4%) stddev-sans-first:2.79 05:09:42 INFO - PROCESS | 10872 | Values: 113.0 104.0 113.0 109.0 110.0 112.0 112.0 113.0 111.0 111.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:155.00 stddev:19.33 (12.5%) stddev-sans-first:20.38 05:09:42 INFO - PROCESS | 10872 | Values: 154.0 133.0 158.0 178.0 126.0 150.0 156.0 127.0 173.0 126.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 05:09:42 INFO - PROCESS | 10872 | Values: 164.0 163.0 161.0 163.0 165.0 162.0 163.0 161.0 161.0 161.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#3] audio-fft Cycles:10 Average:94.40 Median:75.50 stddev:39.71 (52.6%) stddev-sans-first:41.49 05:09:42 INFO - PROCESS | 10872 | Values: 75.0 75.0 76.0 176.0 75.0 76.0 74.0 77.0 163.0 77.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:85.00 stddev:27.82 (32.7%) stddev-sans-first:28.75 05:09:42 INFO - PROCESS | 10872 | Values: 84.0 85.0 146.0 85.0 84.0 85.0 135.0 85.0 85.0 145.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 05:09:42 INFO - PROCESS | 10872 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 117.0 116.0 118.0 118.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:09:42 INFO - PROCESS | 10872 | Values: 147.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 05:09:42 INFO - PROCESS | 10872 | Values: 96.0 95.0 97.0 94.0 95.0 95.0 95.0 96.0 96.0 95.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.63 (3.1%) stddev-sans-first:1.56 05:09:42 INFO - PROCESS | 10872 | Values: 50.0 51.0 55.0 52.0 50.0 52.0 53.0 52.0 51.0 54.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:2.37 (3.9%) stddev-sans-first:2.44 05:09:42 INFO - PROCESS | 10872 | Values: 59.0 63.0 59.0 60.0 62.0 59.0 60.0 59.0 66.0 59.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:78.50 stddev:6.88 (8.8%) stddev-sans-first:7.30 05:09:42 INFO - PROCESS | 10872 | Values: 80.0 76.0 78.0 77.0 79.0 77.0 84.0 78.0 99.0 77.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:128.00 stddev:3.68 (2.9%) stddev-sans-first:3.61 05:09:42 INFO - PROCESS | 10872 | Values: 130.0 129.0 126.0 119.0 127.0 123.0 123.0 130.0 124.0 129.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.50 stddev:2.60 (1.7%) stddev-sans-first:2.76 05:09:42 INFO - PROCESS | 10872 | Values: 155.0 154.0 160.0 156.0 151.0 152.0 156.0 155.0 157.0 153.0 05:09:42 INFO - PROCESS | 10872 | 05:09:42 INFO - PROCESS | 10872 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.65 (2.6%) stddev-sans-first:1.73 05:09:42 INFO - PROCESS | 10872 | Values: 63.0 62.0 66.0 63.0 60.0 63.0 62.0 61.0 63.0 61.0 05:09:42 INFO - PROCESS | 10872 | -------- Summary: end -------- 05:09:42 INFO - PROCESS | 10872 | 05:09:43 INFO - TEST-INFO | 10872: exit 0 05:09:43 INFO - TEST-OK | kraken | took 61314ms 05:09:43 INFO - SUITE-END | took 1171s 05:09:43 INFO - Completed test suite (00:19:31) 05:09:43 INFO - javascript benchmark 05:09:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7644.731882892127, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.7308215342773, 3382.52644629752, 3401.3707464119134, 3425.126592718858, 3427.040428679969, 5649.8305050848485, 5694.800681976127, 5723.456271654191, 5740.368559458456, 5755.568332375078, 5686.971565142178, 5711.971440142794, 5738.770449182028, 5742.196092547037, 5758.136279558068, 5131.33292671953, 5186.507281808223, 5217.191335343028, 5228.947710522884, 5241.554467870235, 5131.307273518083, 5149.0731668299695, 5255.789768409278, 5261.526462618363, 5272.340957380327, 5207.3490813648295, 5221.321228240324, 5246.606504512158, 5263.26314315996, 5267.499587539178, 5228.372595288571, 5250.606204534656, 5317.255584218213, 5327.360716713981, 5329.493698098674, 5209.296744939423, 5247.632665713401, 5310.62825602208, 5310.8141215057285, 5321.680699158062, 5442.673439593637, 5517.944820551783, 5559.527440167551, 5561.998840208761, 5642.463965923231, 6123.846903827395, 6147.323794382614, 6147.969260153715, 6148.84627884302, 6157.96921015392, 6045.939540604626, 6216.627002379826, 6226.688665566749, 6227.657478838662, 6246.3441338659695, 5692.9146062809095, 5735.053716136832, 5740.6268592541355, 5818.2145410369485, 5835.124731290341, 6301.243850737941, 6316.431521163117, 6320.778772742932, 6329.082283069021, 6332.525060620472, 5842.415758424124, 6011.338752737195, 6069.453749162597, 6078.787242446493, 6091.360407157184, 6126.142340072393, 6226.533010024266, 6241.875162496815, 6249.6562689051625, 6249.812505624838, 6197.938020619736, 6203.47270482005, 6227.501799856001, 6228.750849965951, 6235.127082208494, 6009.098635204754, 6082.422169893853, 6111.266648002268, 6207.6275423474735, 6228.128062071313, 4722.338872557844, 4735.479097299294, 4743.359646447754, 4768.451628062817, 4793.0413917216, 4241.151769646083, 4245.044864905433, 4266.381374700651, 4274.1451709658195, 4292.291771857671, 5728.598998070095, 5729.083346664514, 5766.596338256281, 5797.536197104221, 5901.911471327933, 6035.78874739382, 6079.635221886612, 6113.841195312599, 6133.156284163852, 6201.96899015502, 5814.069748840166, 5815.389384114692, 5822.94177058224, 5824.737886795105, 5834.970825145847, 5228.7908483660985, 5306.28365170697, 5358.678479291255, 5367.865803354947, 5383.031054410244, 6296.496280297565, 6310.558260921784, 6336.619802811846, 6339.397757213057, 6347.270063942706, 6055.2430946131735, 6272.435480806749, 6278.183836101278, 6283.96858015707, 6286.402791734778, 6146.631202127886, 6195.907061393992, 6196.504279657706, 6289.213848268966, 6291.056341548804, 6102.298235702951, 6104.633721976696, 6115.571909966259, 6125.142480052886, 6137.478314343331, 6021.54838387114, 6083.726232319467, 6205.844853878689, 6219.782307619393, 6237.532185086227, 5974.715436181242, 6067.029275315928, 6069.575129740876, 6092.45167934888, 6115.266168059861, 5981.461668449861, 5994.910076348945, 6055.848603784941, 6068.544859135494, 6073.817785466443, 5731.455511726379, 5785.363610002981, 5790.971045144747, 5988.461038506555, 5999.040153575407, 5942.405759424023, 5956.047032474783, 5963.612365196248, 5970.955082860569, 6017.458428741435, 5839.532837373085, 5855.033919403421, 5861.794837180678, 5862.912056319074, 5869.559783016205], "value": 5671.817863639983, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.5103466192385, 613.7054213977289, 652.9804105876824, 666.9695320729472, 671.868985547818, 46296.53703462964, 47762.76118619406, 47969.76015119924, 52248.73875630626, 52309.738451307785, 48699.51300486994, 49524.25713614299, 49565.752171239095, 49584.752076239565, 49707.0, 8767.82464350711, 8872.8669069964, 8899.421537600068, 8916.821663566758, 8921.55392230389, 9111.40775849571, 9148.725538233864, 9202.677906273282, 9204.539773011322, 9218.539073046355, 9237.353385263033, 9263.444193348387, 9272.30457715674, 9273.768155796091, 9279.164875161234, 8856.0, 8887.15572020657, 8907.688230911952, 8934.508602026886, 8934.73195804127, 9149.862752058725, 9182.17360437564, 9217.262618990464, 9241.0, 9251.398659087137, 44835.77582112101, 45187.096258074656, 45314.54685453136, 45353.773231133964, 45902.54097459016, 3662.157703728131, 3662.212624285765, 3684.613115622875, 3836.5012548368813, 3837.3284675182013, 32787.3442531148, 33017.17457063569, 33085.503717444255, 35495.29009419823, 36485.817570911975, 4251.702380833343, 4269.573042695737, 4282.464691913511, 4316.395704601358, 4332.458442694663, 393445.0, 395452.0, 397543.0, 398036.9999999971, 398616.0, 37795.81102094472, 65739.34260657428, 67104.66447667828, 67332.0, 67503.32496675069, 38491.42262866059, 40282.79858600747, 40419.19161616751, 40473.0, 40672.38991415131, 16169.514914552583, 16285.59286017859, 16302.755458668129, 16340.83659163417, 16369.508914732578, 13890.097143685629, 13976.88184945202, 14012.789808152886, 14022.509212177525, 14043.71912561743, 8239.299659528888, 8242.052164001216, 8265.876011859827, 8316.958415208006, 8400.243978042006, 3439.3637177122314, 3447.2594287541465, 3471.9826400868337, 3497.440409534462, 3513.5608048993877, 1017.2523195451338, 1033.7260625934134, 1073.6188653028219, 1209.2442223610244, 1218.4638758946212, 33122.3375532488, 33324.83337583345, 33510.16224594356, 33533.49699754506, 34052.659473405445, 1138.3909608359654, 1160.9709757256137, 1201.9038476921826, 1242.1615409598485, 1285.6400207941792, 17527.0, 17647.647047059243, 17670.734938975926, 17860.642787144185, 17871.463856084338, 549476.0, 1004738.0, 1065887.0, 1066243.0, 1075751.0, 62201.68899155475, 62840.0, 63102.68448657727, 63161.368386315546, 63193.68403157955, 1445.4290555230625, 1467.4350375105876, 1478.3716920308825, 1481.1335368809152, 1495.9177245251615, 31540.526892097096, 32094.19764505906, 32477.188070297485, 32613.18467038343, 32766.83616581902, 54248.18627720508, 54744.0, 55220.44779552153, 55237.44762552323, 55275.723621383244, 417233.0, 420745.0, 422397.0, 425219.0, 425830.0, 30440.0, 30528.389432210788, 30776.230594235323, 30934.845325773225, 30986.380272394876, 50051.249231262285, 52823.47176528339, 53091.734541327045, 53160.0, 54152.458475416315, 44570.77714611536, 44839.0, 44852.77573612111, 45252.32121518114, 46775.29837052515, 43143.137137257705, 44682.55317446914, 44697.0, 45079.0, 45567.54432455633, 44547.331790023825, 45478.317825231985, 45915.0, 45923.31115033344, 46066.0, 37910.2417951645, 38359.42460863145, 38875.0, 39928.2014359717, 40081.39877901892, 29727.851360743058, 29984.25039374033, 30016.446957312968, 30249.546256805726, 30415.239619009702], "value": 20405.70787541887, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.7074329624432, 399.51059951559364, 428.676349356236, 428.94209281746964, 430.3652113133127, 16764.07797571133, 17183.82816171838, 18391.816081839177, 18509.53726156847, 20214.797852021475, 12266.693332666688, 12467.127301088905, 12567.937160314186, 16286.7556986645, 17669.46991590251, 5210.843674689756, 5389.73051347433, 5403.378611459673, 5409.783608655649, 5419.945800541984, 5462.754176062067, 5732.656040637554, 5755.0504166812425, 5827.796027139051, 5833.679147646878, 5774.220480235177, 5828.708564571754, 6415.903761443582, 6617.735290588371, 6623.437007854314, 6001.159837622737, 6575.375339342755, 6584.242812076624, 6601.900971485432, 6611.074449577063, 5789.681567513785, 5829.970850145722, 5851.707414629294, 5854.326752423483, 5871.1193321001765, 19399.709004364944, 21082.683759743617, 23118.306450806504, 24092.518149637086, 24110.879445602834, 2331.0, 2416.0577374823833, 2464.002079157926, 2621.1377894006723, 2751.119641714652, 9946.403215807075, 10604.04563589273, 10889.292196007234, 13361.799573006412, 14102.365393557211, 2030.3807338761671, 2042.8263597594223, 2055.393658870622, 2126.723525941633, 2161.481244501324, 79600.60199698964, 84571.57714211452, 85320.57339713324, 85323.99999999937, 85676.0, 10757.623483178051, 10782.299150555345, 10969.670909872717, 10996.23026388161, 11153.275037122561, 14575.489857854924, 14740.926295368668, 14748.852511474963, 14749.0, 14869.330880110421, 8229.382796290301, 8400.369972252105, 8446.324294056583, 8458.915410845935, 8468.153184681483, 8182.345412366996, 8350.665973360998, 8365.8326833463, 8403.201695838885, 8488.872666910001, 4344.304911214191, 4345.435093437896, 4476.888077798081, 4484.955150448519, 4504.81980720774, 1929.3440230321758, 1930.1700268884515, 2032.400441869652, 2148.409187473426, 2181.5854987552316, 923.8660394242797, 962.7978124593774, 1042.635077722806, 1076.7684947736275, 1079.5250089960393, 17995.640087198182, 18915.14881830321, 19993.600127997357, 20129.698054529195, 20141.0, 1065.79217052674, 1073.4954571351452, 1078.336822853939, 1096.2381145104075, 1163.5055101581963, 11021.393823339633, 11117.888821111685, 11130.888691113147, 11172.44137793107, 11174.776504469864, 502108.0, 502341.0, 509711.0, 549421.0, 573167.0, 88478.0, 88890.0, 91665.0, 92053.53973230091, 101445.98554014514, 1066.184368957748, 1107.545906178479, 1109.9334039957628, 1114.2033446086086, 1115.041064684371, 18019.639607208046, 18253.634927301115, 18320.725189121906, 18383.632327353647, 18406.0, 40885.591144088175, 42044.0, 43543.78228108966, 44294.33558496561, 44371.77814110909, 57750.0, 57994.0, 63413.68293158689, 63622.68188659027, 63724.362756373695, 6169.827732730767, 8723.214910658071, 8784.692535761218, 8860.778480538038, 8891.866622000545, 12604.432800524182, 13174.011949103664, 13203.867961320264, 14049.508267211007, 14056.297185140907, 12148.453319600463, 12461.750764984468, 12540.934020607985, 12567.874321257035, 12656.936715316364, 11962.282263064244, 12311.44598493052, 12468.438920248429, 12545.87454125447, 12583.622491325275, 12484.750304994031, 12720.109592328448, 12772.808407873703, 12773.8083928743, 12847.0, 8855.512946787989, 9090.772730681785, 9157.816843663222, 9277.072292770668, 9328.207102396102, 9370.672026479313, 12393.318367489876, 12521.31132787669, 12680.302583358003, 12699.174553653984], "value": 9467.641745153169, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.6424322405842, 1595.5771720494067, 1781.4032299179773, 1900.8099190080993, 1908.8950107744085, 8599.484030958147, 9190.356675032743, 9300.11648893354, 9841.163501102406, 9882.160016398606, 9329.486878221694, 9500.667476638318, 9671.903280967188, 9848.113669769718, 9899.208063354932, 2538.9746102538925, 2546.2361291612533, 2583.7287084856007, 2587.4436996045847, 2597.2078516052693, 2532.2656429635476, 2549.528337257613, 2550.6429099926027, 2550.681164854393, 2550.872456377174, 2507.047322017631, 2526.835755675875, 2528.506941146477, 2529.4941011797714, 2540.8602526861014, 2439.5974664180476, 2444.498877730061, 2447.4737931344666, 2450.3506570758764, 2494.5634513959985, 2480.9379765506005, 2483.689538807649, 2498.362917456037, 2523.962140567893, 2527.7093134289607, 9850.753731156707, 9909.157721593674, 9939.204863610894, 9947.55236014381, 9955.75110622233, 5707.115397113413, 5848.619839710405, 5888.646681199099, 5889.734961926723, 5897.764089436418, 3612.331718632035, 3794.772313661189, 3824.1969186470874, 3845.0964023454467, 3890.8832735017995, 1151.3437340715795, 1195.8684544700077, 1198.1253684810051, 1217.7564487102616, 1261.0290076640936, 13916.721665566633, 13934.721305573832, 13983.0, 14017.85982140186, 14037.508687196001, 4878.975605121952, 4910.950890491049, 5006.224035274538, 5039.874003149951, 5081.644284900095, 10962.835557466644, 10980.835287470694, 11001.834972475419, 11021.118310535137, 11025.944870275598, 5619.26949496571, 5683.715814209356, 5688.54491640676, 5706.258186435737, 5718.68547229898, 4679.2045352289515, 5074.695518268842, 5194.3247377840635, 5198.532132108128, 5268.894622107537, 4190.790460477025, 4217.0511634881905, 4261.275583150872, 4270.594293542171, 4312.978435107804, 1228.6744012836605, 1282.4421376701164, 1285.736424033071, 1289.3231053696884, 1289.8452185737583, 902.4404868981273, 1092.4592326798286, 1096.4627332606965, 1101.2755279849357, 1133.8525991621202, 6490.318516555788, 6650.9667451662435, 6699.464042876558, 6763.256041835394, 6780.660966951731, 1003.0922015575916, 1013.2198207380276, 1025.1849779425374, 1082.2099867097063, 1086.473060565625, 4625.098105869323, 4723.976380118146, 4735.0, 4760.809567617326, 4771.95228047715, 12269.141160118706, 12381.0, 12531.621521632613, 12650.557230496888, 12668.746625067632, 12425.316607586488, 12557.309347985765, 12595.24428534291, 12595.433205505775, 12631.305278209604, 8754.430961987451, 8864.778380540538, 8903.465792052497, 8962.283017358595, 9117.088291170963, 6666.600003999775, 6671.0, 6702.530822842355, 6828.453723702191, 6859.725610975505, 11221.831672525082, 11389.031932285849, 11399.145064120059, 11558.30650160993, 11596.188266821242, 11606.593769218036, 11719.355435451133, 11734.530618775154, 11740.530378784753, 11885.5840045598, 8088.9595552021865, 8116.350691944748, 8120.796980075545, 8140.674373025249, 8142.796430089295, 9401.905980940102, 9479.241660667269, 9502.239820814457, 9528.047195280416, 9528.475933823429, 8181.550014749246, 8257.133001035045, 8621.482711037357, 8673.956630216808, 8749.518776467356, 8346.874796878174, 8418.957905210435, 8423.452475589067, 8439.493630382196, 8466.365022623451, 8079.434439589172, 8139.308158806568, 8167.550784706898, 8168.632411541614, 8200.179982001991, 5718.1708652246025, 5868.471837534642, 5883.0881213411985, 5986.2217911671205, 5995.730192141277, 5957.927573036895, 6026.7287972040485, 6037.818865434044, 6104.9389506106145, 6114.021756519113], "value": 5128.889748596674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.8235161836799, 326.5591451540419, 328.99013029609114, 337.8006975884228, 340.0953463786329, 5708.486236238738, 5751.009475072965, 5778.428599273325, 5826.650400975945, 5836.562257830664, 5617.21359009739, 5655.784006438615, 5683.943160568393, 5689.4879460848515, 5708.316046766204, 4352.847650332239, 4398.362237475564, 4433.600975912167, 4458.595542404132, 4471.19518486673, 4349.826006959718, 4386.934195987063, 4398.64810815134, 4404.163208990298, 4410.272305069676, 4340.218760623086, 4356.803943822536, 4385.6710746694125, 4408.669349798778, 4444.422225110731, 4170.833166673329, 4243.893902652443, 4308.612224899774, 4320.870373888788, 4345.521992580813, 3784.2620688965662, 3805.429185622151, 3811.161544460242, 3831.9042023949346, 3865.845366185349, 5441.782328706847, 5457.263269458612, 5467.972660136674, 5521.751521181516, 5531.778728850841, 4919.26211068339, 4994.87512812179, 5028.5977121830165, 5041.445441001487, 5097.923531147036, 5952.1964534787685, 5981.8803623927715, 5995.280566332024, 6005.549583781234, 6021.488173505258, 4228.71796406887, 4231.42875711778, 4277.636400905927, 4283.907603561072, 4306.6554675626185, 6098.115773212904, 6104.26748790148, 6110.29731580865, 6152.2924863640355, 6176.84557886052, 4352.760598167131, 4374.300111982067, 4399.274119770266, 4400.0, 4413.205622987829, 4348.543402942709, 4442.244818380883, 4442.666799990014, 4447.3773671685985, 4449.154660614473, 4964.975175124174, 5010.348654674942, 5021.447640759587, 5036.949630503721, 5040.621953353513, 5898.203742494794, 5960.940390596125, 5972.372900845436, 5992.64044157352, 6082.209312789398, 1494.8430414806505, 1533.3789815124892, 1540.4762380790585, 1557.9298931548108, 1560.867326277279, 957.5116690487902, 969.3553786731885, 984.5077461269366, 990.153418826907, 990.9495934309655, 5023.397192336943, 5056.710538812579, 5073.057626576577, 5083.161278389099, 5127.53852153308, 5384.78460861569, 5464.535514481314, 5509.0, 5520.267467603562, 5581.023320918823, 5124.590032797368, 5497.587680923947, 5774.740136693775, 5784.074548072373, 5805.506531944832, 3319.27397753167, 3330.733541316689, 3369.730421566269, 3372.662733726657, 3373.915652108717, 6003.699815009232, 6225.3774622538285, 6244.937550624527, 6278.434940855345, 6303.243610766737, 6277.089821975788, 6290.276618188876, 6300.30696623371, 6305.274893387319, 6331.96834015827, 6086.6652334122045, 6235.532335074888, 6243.594166379171, 6254.249490061131, 6284.0, 6089.0, 6160.599561028698, 6179.3820617937845, 6264.404881536247, 6264.5301602379095, 6020.849478763066, 6037.09443583466, 6038.403486500847, 6062.514998800174, 6088.939110608837, 6030.85413771382, 6163.876722465615, 6233.719482623384, 6253.1245625613365, 6281.685915704105, 4299.140171965682, 4304.4834619845815, 4328.567143285646, 4339.1972485090355, 4351.803254105146, 5947.940520594739, 6276.372362763687, 6289.245290564979, 6313.494920406449, 6316.968415157895, 6020.819375418744, 6047.818565443044, 6054.243219597551, 6074.90887636677, 6081.817545473643, 6054.759738896636, 6062.484688801501, 6074.90887636677, 6114.877702446015, 6119.388061194023, 5664.461876121762, 5930.733117009659, 5944.256967879015, 5950.910736338872, 5990.903183885605, 5969.91045134332, 6040.7347244783205, 6073.993373280078, 6095.908561371672, 6105.236845394325, 5697.4302569742695, 5782.624129431573, 5920.319163296276, 5927.881442371215, 5997.570983751588], "value": 4508.801116667059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.8336257704595, 777.024833833539, 779.1624004195484, 811.991880081199, 817.7342363731786, 15488.612784680388, 16766.245518951648, 16774.58063548412, 16801.747973780373, 16966.660666786673, 15401.0, 15680.215989200522, 15739.134347610876, 15744.763828542553, 16701.164941752926, 838.995805020974, 845.995770021149, 848.2916764501648, 848.9320854331638, 849.9830003399928, 855.0807881527352, 855.8844555984956, 856.6787454704486, 860.109786371106, 862.9439086459391, 900.9639614415415, 909.068205089785, 910.1444642036464, 912.803747194353, 916.8533034714447, 892.8883889513811, 897.8114595934796, 899.9955000225023, 902.1024081039375, 902.9413088149249, 661.8874791285493, 662.4634046422414, 662.867426514699, 663.1677245057471, 664.5713514782938, 16573.4199303025, 16668.33326666932, 16771.413000544922, 16783.748243776354, 16804.075775832323, 14659.34032968519, 14996.25018749069, 15316.846831531653, 15650.68698626021, 15695.450659226986, 12330.260184388966, 12434.689132771662, 12841.165324253894, 12897.484100635964, 13280.07039507235, 3984.880453586397, 4078.0, 4138.586141385837, 4140.0, 4177.289860723654, 67690.66154669244, 70887.2911270891, 71435.92846107365, 76846.61576692137, 80355.0, 12385.442655080544, 12616.0, 12703.428345724464, 12806.0, 12978.156419832869, 22469.213577524708, 22497.212597559006, 22656.773432265796, 22676.88661556682, 22684.092636294692, 9412.717618471457, 9449.244060475145, 9574.808503829885, 9705.514724263758, 9815.852762208573, 5109.616778741609, 5235.528802407725, 5235.712035837989, 5295.338082739658, 5349.545288650431, 3999.680025597945, 4068.1253530491085, 4116.958830411658, 4127.277726397869, 4142.482189726285, 716.8888822232562, 723.1502983993892, 737.498501019312, 741.5624781379013, 744.4528271720282, 622.3838399983983, 724.5326764237037, 724.731849215783, 724.9601271930095, 732.3372348025046, 10166.847497287547, 10281.948590257001, 10311.175105991502, 10502.212334074975, 10554.577816887391, 723.5224751663876, 737.3189128786375, 738.5273425007999, 739.8187444076236, 760.69572171132, 4610.008848097675, 4674.018456124184, 4696.5303469653445, 4708.246680531099, 4739.644526660514, 71567.6421617899, 71997.64001179961, 115295.0, 117054.0, 120066.0, 62104.689476552325, 64490.35509644844, 67138.0, 87840.5607971956, 101693.0, 75680.62159689167, 83182.0, 84060.73908891372, 84947.5752621233, 85675.57162214149, 9568.521573921136, 9696.272779541421, 9705.466199359103, 9860.0, 10100.646477373257, 47794.0, 49037.0, 51231.0, 52493.0, 53223.4677653234, 67820.6608966952, 76559.8516022249, 76768.84846727415, 76926.0, 77053.61473192598, 13017.869821302045, 13068.54260100892, 13275.700540803156, 13790.724185516434, 13965.650858728613, 15177.6205594861, 15414.306356213772, 15627.921860390625, 15849.52451426459, 16473.423430179886, 13740.587782366545, 13747.312634368442, 13797.724045519235, 13882.0, 14728.484503042342, 13683.794743079061, 13788.820492947743, 13852.584422467342, 13969.790453143414, 14397.064190827563, 14122.929385353007, 14212.857871421153, 14366.3535140921, 14596.270186490845, 15314.770278445609, 11603.709907252387, 11776.4700588472, 11945.82081268799, 12016.158868879444, 12222.755544888874, 12235.93882030584, 12329.568465103679, 12485.937570312453, 12668.366581670694, 12780.61658150257], "value": 7876.519596567998, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 113.0, 109.0, 110.0, 112.0, 112.0, 113.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 158.0, 178.0, 126.0, 150.0, 156.0, 127.0, 173.0, 126.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 163.0, 165.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 176.0, 75.0, 76.0, 74.0, 77.0, 163.0, 77.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 146.0, 85.0, 84.0, 85.0, 135.0, 85.0, 85.0, 145.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 116.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 55.0, 52.0, 50.0, 52.0, 53.0, 52.0, 51.0, 54.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 59.0, 60.0, 62.0, 59.0, 60.0, 59.0, 66.0, 59.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 78.0, 77.0, 79.0, 77.0, 84.0, 78.0, 99.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 126.0, 119.0, 127.0, 123.0, 123.0, 130.0, 124.0, 129.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 160.0, 156.0, 151.0, 152.0, 156.0, 155.0, 157.0, 153.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 66.0, 63.0, 60.0, 63.0, 62.0, 61.0, 63.0, 61.0], "value": 62.4, "unit": "score"}]}]} 05:09:43 INFO - Return code: 0 05:09:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:09:43 ERROR - # TBPL SUCCESS # 05:09:43 INFO - Running post-action listener: _resource_record_post_action 05:09:43 INFO - ##### 05:09:43 INFO - ##### Finished run-tests step (success) 05:09:43 INFO - ##### 05:09:43 INFO - Running post-run listener: _resource_record_post_run 05:09:43 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271605760; Read time: 368; Write time: 224932 05:09:43 INFO - TinderboxPrint: CPU usage
13.4% 05:09:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 368 05:09:43 INFO - TinderboxPrint: I/O write bytes / time
271,605,760 / 224,932 05:09:43 INFO - TinderboxPrint: CPU idle
8,219.4 (86.6%) 05:09:43 INFO - TinderboxPrint: CPU user
1,211.9 (12.8%) 05:09:43 INFO - TinderboxPrint: Swap in / out
0 / 0 05:09:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20393984; Read time: 0; Write time: 3584 05:09:43 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 246009856; Read time: 368; Write time: 219932 05:09:44 INFO - Running post-run listener: _upload_blobber_files 05:09:44 INFO - Blob upload gear active. 05:09:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:09:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:09:44 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:09:44 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:09:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:09:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:09:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:45 INFO - (blobuploader) - INFO - Done attempting. 05:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:46 INFO - (blobuploader) - INFO - Done attempting. 05:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:52 INFO - (blobuploader) - INFO - Done attempting. 05:09:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:09:52 INFO - Return code: 0 05:09:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:09:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:09:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/352cb8dfd70f99636f1ee137dfd088d6dd75c10c4c7dff65c956727ec39f5dfff385bf3815e4f1904e8d8028a541c49982dfec04764b6c8b0afbfa67ddddb383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb816121b4c51f9c52a7bf622cf6d0001c157d8444905351716ed9b011e61e74c1fa8a6785bf4e55650aa69b3c38cada3e23dc1779e95f37717f3659daf8c98d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8fda1b67806126670a07b913ee0f26e187ad97c97315754ff9ef85de8cc5ee130b59797c066b234b136300653cdf66b42aa6dae86dec747c6cbcefee326c843"} 05:09:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:09:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:09:52 INFO - Contents: 05:09:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/352cb8dfd70f99636f1ee137dfd088d6dd75c10c4c7dff65c956727ec39f5dfff385bf3815e4f1904e8d8028a541c49982dfec04764b6c8b0afbfa67ddddb383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb816121b4c51f9c52a7bf622cf6d0001c157d8444905351716ed9b011e61e74c1fa8a6785bf4e55650aa69b3c38cada3e23dc1779e95f37717f3659daf8c98d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8fda1b67806126670a07b913ee0f26e187ad97c97315754ff9ef85de8cc5ee130b59797c066b234b136300653cdf66b42aa6dae86dec747c6cbcefee326c843"} 05:09:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:09:52 INFO - Copying logs to upload dir... 05:09:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:09:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.597275 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-25 05:09:51.868046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:09:51.874493) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/352cb8dfd70f99636f1ee137dfd088d6dd75c10c4c7dff65c956727ec39f5dfff385bf3815e4f1904e8d8028a541c49982dfec04764b6c8b0afbfa67ddddb383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb816121b4c51f9c52a7bf622cf6d0001c157d8444905351716ed9b011e61e74c1fa8a6785bf4e55650aa69b3c38cada3e23dc1779e95f37717f3659daf8c98d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8fda1b67806126670a07b913ee0f26e187ad97c97315754ff9ef85de8cc5ee130b59797c066b234b136300653cdf66b42aa6dae86dec747c6cbcefee326c843"} build_url:https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/cNhI90E1TrKXEXUhhFF6Dw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/352cb8dfd70f99636f1ee137dfd088d6dd75c10c4c7dff65c956727ec39f5dfff385bf3815e4f1904e8d8028a541c49982dfec04764b6c8b0afbfa67ddddb383", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fb816121b4c51f9c52a7bf622cf6d0001c157d8444905351716ed9b011e61e74c1fa8a6785bf4e55650aa69b3c38cada3e23dc1779e95f37717f3659daf8c98d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8fda1b67806126670a07b913ee0f26e187ad97c97315754ff9ef85de8cc5ee130b59797c066b234b136300653cdf66b42aa6dae86dec747c6cbcefee326c843"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:09:51.902341) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:09:51.903053) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469447339.353422-1763431679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:09:51.987902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:09:51.988654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:09:51.989358) ========= ========= Total master_lag: 0.19 =========