builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1469447097.87 results: success (0) buildid: 20160725020629 builduid: e9cffd69a2054ead90893fbe00f05894 revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:57.870254) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:57.870744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:57.871021) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:57.887426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:57.887793) ========= 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=232498196343f89f466a4a9a000001c8-1469446835.232348-903693951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 04:44:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.0M=0s 2016-07-25 04:44:59 (50.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:57.993086) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:57.993726) ========= 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=232498196343f89f466a4a9a000001c8-1469446835.232348-903693951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018990 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:58.051230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:58.054678) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 --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=232498196343f89f466a4a9a000001c8-1469446835.232348-903693951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 04:44:59,557 truncating revision to first 12 chars 2016-07-25 04:44:59,557 Setting DEBUG logging. 2016-07-25 04:44:59,557 attempt 1/10 2016-07-25 04:44:59,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/517663b29d7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 04:44:59,883 unpacking tar archive at: mozilla-aurora-517663b29d7f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:58.687114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:58.687437) ========= script_repo_revision: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:58.687938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:58.688222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:44:58.697635) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-25 04:44:58.698010) ========= /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=232498196343f89f466a4a9a000001c8-1469446835.232348-903693951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:45:00 INFO - MultiFileLogger online at 20160725 04:45:00 in /builds/slave/test 04:45:00 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:45:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:00 INFO - {'append_to_log': False, 04:45:00 INFO - 'base_work_dir': '/builds/slave/test', 04:45:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:45:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:00 INFO - 'branch': 'Mozilla-Aurora', 04:45:00 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:00 INFO - 'config_files': ('talos/linux_config.py',), 04:45:00 INFO - 'default_actions': ('clobber', 04:45:00 INFO - 'read-buildbot-config', 04:45:00 INFO - 'download-and-extract', 04:45:00 INFO - 'populate-webroot', 04:45:00 INFO - 'create-virtualenv', 04:45:00 INFO - 'install', 04:45:00 INFO - 'run-tests'), 04:45:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:00 INFO - 'download_minidump_stackwalk': True, 04:45:00 INFO - 'download_symbols': 'ondemand', 04:45:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:00 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:00 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:00 INFO - 'installer_path': 'installer.exe', 04:45:00 INFO - 'log_level': 'info', 04:45:00 INFO - 'log_name': 'talos', 04:45:00 INFO - 'log_to_console': True, 04:45:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:45:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:45:00 INFO - 'opt_config_files': (), 04:45:00 INFO - 'pip_index': False, 04:45:00 INFO - 'sps_profile': False, 04:45:00 INFO - 'sps_profile_interval': 0, 04:45:00 INFO - 'suite': 'dromaeojs-e10s', 04:45:00 INFO - 'system_bits': '32', 04:45:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:00 INFO - 'title': 'talos-linux64-ix-025', 04:45:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:00 INFO - 'use_talos_json': True, 04:45:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:00 INFO - 'work_dir': 'build'} 04:45:00 INFO - ##### 04:45:00 INFO - ##### Running clobber step. 04:45:00 INFO - ##### 04:45:00 INFO - Running pre-action listener: _resource_record_pre_action 04:45:00 INFO - Running main action method: clobber 04:45:00 INFO - rmtree: /builds/slave/test/build 04:45:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:01 INFO - Running post-action listener: _resource_record_post_action 04:45:01 INFO - ##### 04:45:01 INFO - ##### Finished clobber step (success) 04:45:01 INFO - ##### 04:45:01 INFO - ##### 04:45:01 INFO - ##### Running read-buildbot-config step. 04:45:01 INFO - ##### 04:45:01 INFO - Running pre-action listener: _resource_record_pre_action 04:45:01 INFO - Running main action method: read_buildbot_config 04:45:01 INFO - Using buildbot properties: 04:45:01 INFO - { 04:45:01 INFO - "project": "", 04:45:01 INFO - "product": "firefox", 04:45:01 INFO - "script_repo_revision": "production", 04:45:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:45:01 INFO - "repository": "", 04:45:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:45:01 INFO - "buildid": "20160725020629", 04:45:01 INFO - "pgo_build": "True", 04:45:01 INFO - "basedir": "/builds/slave/test", 04:45:01 INFO - "buildnumber": 460, 04:45:01 INFO - "slavename": "talos-linux64-ix-025", 04:45:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:45:01 INFO - "platform": "ubuntu64_hw", 04:45:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:45:01 INFO - "branch": "mozilla-aurora", 04:45:01 INFO - "repo_path": "releases/mozilla-aurora", 04:45:01 INFO - "revision": "517663b29d7ffc2ce91f90dc7beaac4fa35e52e5", 04:45:01 INFO - "stage_platform": "linux64-pgo", 04:45:01 INFO - "builduid": "e9cffd69a2054ead90893fbe00f05894", 04:45:01 INFO - "slavebuilddir": "test" 04:45:01 INFO - } 04:45:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:45:01 INFO - Running post-action listener: _resource_record_post_action 04:45:01 INFO - ##### 04:45:01 INFO - ##### Finished read-buildbot-config step (success) 04:45:01 INFO - ##### 04:45:01 INFO - ##### 04:45:01 INFO - ##### Running download-and-extract step. 04:45:01 INFO - ##### 04:45:01 INFO - Running pre-action listener: _resource_record_pre_action 04:45:01 INFO - Running main action method: download_and_extract 04:45:01 INFO - mkdir: /builds/slave/test/build/tests 04:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:01 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:05 INFO - Downloaded 1361 bytes. 04:45:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:45:05 INFO - Using the following test package requirements: 04:45:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:45:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:45:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'jsshell-linux-x86_64.zip'], 04:45:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:45:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:45:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:45:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:45:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:45:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:45:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:45:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:05 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:07 INFO - Downloaded 24494715 bytes. 04:45:07 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:45:07 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:45:08 INFO - Return code: 0 04:45:08 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:45:08 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:45:08 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:11 INFO - Downloaded 24494715 bytes. 04:45:11 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:45:11 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:45:13 INFO - Return code: 0 04:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:13 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:45:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:45:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:15 INFO - Downloaded 10833369 bytes. 04:45:15 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:45:15 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:45:15 INFO - Return code: 0 04:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:15 INFO - https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:45:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FBJIZmzeRzWE48WjAir0jg/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:45:19 INFO - Downloaded 63633994 bytes. 04:45:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:19 INFO - mkdir: /builds/slave/test/properties 04:45:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:45:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:45:19 INFO - Contents: 04:45:19 INFO - build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:45:20 INFO - Running post-action listener: _resource_record_post_action 04:45:20 INFO - Running post-action listener: set_extra_try_arguments 04:45:20 INFO - ##### 04:45:20 INFO - ##### Finished download-and-extract step (success) 04:45:20 INFO - ##### 04:45:20 INFO - ##### 04:45:20 INFO - ##### Running populate-webroot step. 04:45:20 INFO - ##### 04:45:20 INFO - Running pre-action listener: _resource_record_pre_action 04:45:20 INFO - Running main action method: populate_webroot 04:45:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:45:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:45:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:45:20 INFO - '--tppagecycles', 04:45:20 INFO - '7'], 04:45:20 INFO - 'tests': ['tsvgm']}}, 04:45:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:45:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:45:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:45:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:45:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:45:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['damp', 'tps']}, 04:45:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'tests': ['damp', 'tps']}, 04:45:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['dromaeo_dom']}, 04:45:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:45:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['a11yr', 04:45:20 INFO - 'ts_paint', 04:45:20 INFO - 'tpaint', 04:45:20 INFO - 'sessionrestore', 04:45:20 INFO - 'sessionrestore_no_auto_restore', 04:45:20 INFO - 'tabpaint']}, 04:45:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:45:20 INFO - 'ts_paint', 04:45:20 INFO - 'tpaint', 04:45:20 INFO - 'sessionrestore', 04:45:20 INFO - 'sessionrestore_no_auto_restore', 04:45:20 INFO - 'tabpaint']}, 04:45:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:45:20 INFO - 'ts_paint', 04:45:20 INFO - 'tpaint', 04:45:20 INFO - 'sessionrestore', 04:45:20 INFO - 'sessionrestore_no_auto_restore', 04:45:20 INFO - 'tabpaint']}, 04:45:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:45:20 INFO - 'ts_paint', 04:45:20 INFO - 'tpaint', 04:45:20 INFO - 'sessionrestore', 04:45:20 INFO - 'sessionrestore_no_auto_restore', 04:45:20 INFO - 'tabpaint']}, 04:45:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['a11yr', 04:45:20 INFO - 'ts_paint', 04:45:20 INFO - 'tpaint', 04:45:20 INFO - 'sessionrestore', 04:45:20 INFO - 'sessionrestore_no_auto_restore', 04:45:20 INFO - 'tabpaint']}, 04:45:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['a11yr', 04:45:20 INFO - 'ts_paint', 04:45:20 INFO - 'tpaint', 04:45:20 INFO - 'sessionrestore', 04:45:20 INFO - 'sessionrestore_no_auto_restore', 04:45:20 INFO - 'tabpaint']}, 04:45:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['tsvgx', 04:45:20 INFO - 'tsvgr_opacity', 04:45:20 INFO - 'tart', 04:45:20 INFO - 'tscrollx', 04:45:20 INFO - 'cart']}, 04:45:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:45:20 INFO - 'tsvgr_opacity', 04:45:20 INFO - 'tart', 04:45:20 INFO - 'tscrollx', 04:45:20 INFO - 'cart']}, 04:45:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--disable-e10s'], 04:45:20 INFO - 'tests': ['tp5o']}, 04:45:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'tests': ['tp5o']}, 04:45:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--disable-e10s', 04:45:20 INFO - '--xperf_path', 04:45:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:20 INFO - 'tests': ['tp5n']}, 04:45:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:45:20 INFO - 'talos_options': ['--xperf_path', 04:45:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:45:20 INFO - 'tests': ['tp5n']}}, 04:45:20 INFO - 'talos.zip': {'path': '', 04:45:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:45:20 INFO - Running post-action listener: _resource_record_post_action 04:45:20 INFO - ##### 04:45:20 INFO - ##### Finished populate-webroot step (success) 04:45:20 INFO - ##### 04:45:20 INFO - ##### 04:45:20 INFO - ##### Running create-virtualenv step. 04:45:20 INFO - ##### 04:45:20 INFO - Running pre-action listener: _resource_record_pre_action 04:45:20 INFO - Running main action method: create_virtualenv 04:45:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:45:20 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:45:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:45:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:45:20 INFO - Using real prefix '/usr' 04:45:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:22 INFO - Installing pip.................done. 04:45:22 INFO - Return code: 0 04:45:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:45:22 INFO - Using env: {'DISPLAY': ':0', 04:45:22 INFO - 'HOME': '/home/cltbld', 04:45:22 INFO - 'LANG': 'en_US.UTF-8', 04:45:22 INFO - 'LANGUAGE': 'en_US:en', 04:45:22 INFO - 'LOGNAME': 'cltbld', 04:45:22 INFO - 'MAIL': '/var/mail/cltbld', 04:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:22 INFO - 'MOZ_NO_REMOTE': '1', 04:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:22 INFO - 'NO_EM_RESTART': '1', 04:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:22 INFO - 'PWD': '/builds/slave/test', 04:45:22 INFO - 'SHELL': '/bin/bash', 04:45:22 INFO - 'SHLVL': '1', 04:45:22 INFO - 'TERM': 'linux', 04:45:22 INFO - 'TMOUT': '86400', 04:45:22 INFO - 'USER': 'cltbld', 04:45:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:22 INFO - '_': '/tools/buildbot/bin/python'} 04:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:23 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:45:23 INFO - Cleaning up... 04:45:23 INFO - Return code: 0 04:45:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:45:23 INFO - Using env: {'DISPLAY': ':0', 04:45:23 INFO - 'HOME': '/home/cltbld', 04:45:23 INFO - 'LANG': 'en_US.UTF-8', 04:45:23 INFO - 'LANGUAGE': 'en_US:en', 04:45:23 INFO - 'LOGNAME': 'cltbld', 04:45:23 INFO - 'MAIL': '/var/mail/cltbld', 04:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:23 INFO - 'MOZ_NO_REMOTE': '1', 04:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:23 INFO - 'NO_EM_RESTART': '1', 04:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:23 INFO - 'PWD': '/builds/slave/test', 04:45:23 INFO - 'SHELL': '/bin/bash', 04:45:23 INFO - 'SHLVL': '1', 04:45:23 INFO - 'TERM': 'linux', 04:45:23 INFO - 'TMOUT': '86400', 04:45:23 INFO - 'USER': 'cltbld', 04:45:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:23 INFO - '_': '/tools/buildbot/bin/python'} 04:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:23 INFO - Downloading/unpacking psutil>=3.1.1 04:45:23 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:45:23 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:45:23 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:45:23 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:45:23 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:45:23 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:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:25 INFO - Installing collected packages: psutil 04:45:25 INFO - Running setup.py install for psutil 04:45:25 INFO - building 'psutil._psutil_linux' extension 04:45:25 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:45:25 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:45:25 INFO - building 'psutil._psutil_posix' extension 04:45:25 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:45:25 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:45:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:25 INFO - Successfully installed psutil 04:45:25 INFO - Cleaning up... 04:45:25 INFO - Return code: 0 04:45:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:45:25 INFO - Using env: {'DISPLAY': ':0', 04:45:25 INFO - 'HOME': '/home/cltbld', 04:45:25 INFO - 'LANG': 'en_US.UTF-8', 04:45:25 INFO - 'LANGUAGE': 'en_US:en', 04:45:25 INFO - 'LOGNAME': 'cltbld', 04:45:25 INFO - 'MAIL': '/var/mail/cltbld', 04:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:25 INFO - 'MOZ_NO_REMOTE': '1', 04:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:25 INFO - 'NO_EM_RESTART': '1', 04:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:25 INFO - 'PWD': '/builds/slave/test', 04:45:25 INFO - 'SHELL': '/bin/bash', 04:45:25 INFO - 'SHLVL': '1', 04:45:25 INFO - 'TERM': 'linux', 04:45:25 INFO - 'TMOUT': '86400', 04:45:25 INFO - 'USER': 'cltbld', 04:45:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:25 INFO - '_': '/tools/buildbot/bin/python'} 04:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:40 INFO - Installing collected packages: mozsystemmonitor 04:45:40 INFO - Running setup.py install for mozsystemmonitor 04:45:40 INFO - Successfully installed mozsystemmonitor 04:45:40 INFO - Cleaning up... 04:45:40 INFO - Return code: 0 04:45:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:40 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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:40 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:45:40 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:45:40 INFO - Using env: {'DISPLAY': ':0', 04:45:40 INFO - 'HOME': '/home/cltbld', 04:45:40 INFO - 'LANG': 'en_US.UTF-8', 04:45:40 INFO - 'LANGUAGE': 'en_US:en', 04:45:40 INFO - 'LOGNAME': 'cltbld', 04:45:40 INFO - 'MAIL': '/var/mail/cltbld', 04:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:40 INFO - 'MOZ_NO_REMOTE': '1', 04:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:40 INFO - 'NO_EM_RESTART': '1', 04:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:40 INFO - 'PWD': '/builds/slave/test', 04:45:40 INFO - 'SHELL': '/bin/bash', 04:45:40 INFO - 'SHLVL': '1', 04:45:40 INFO - 'TERM': 'linux', 04:45:40 INFO - 'TMOUT': '86400', 04:45:40 INFO - 'USER': 'cltbld', 04:45:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:40 INFO - '_': '/tools/buildbot/bin/python'} 04:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:40 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:45:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:43 INFO - warning: no files found matching '*.txt' 04:45:43 INFO - no previously-included directories found matching 'build' 04:45:43 INFO - no previously-included directories found matching 'dist' 04:45:43 INFO - no previously-included directories found matching '.git*' 04:45:43 INFO - Installing collected packages: jsonschema, functools32 04:45:43 INFO - Running setup.py install for functools32 04:45:43 INFO - warning: no files found matching '*.txt' 04:45:43 INFO - no previously-included directories found matching 'build' 04:45:43 INFO - no previously-included directories found matching 'dist' 04:45:43 INFO - no previously-included directories found matching '.git*' 04:45:43 INFO - Successfully installed jsonschema functools32 04:45:43 INFO - Cleaning up... 04:45:43 INFO - Return code: 0 04:45:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45:43 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:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:43 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:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:43 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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:43 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:45:43 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:45:43 INFO - Using env: {'DISPLAY': ':0', 04:45:43 INFO - 'HOME': '/home/cltbld', 04:45:43 INFO - 'LANG': 'en_US.UTF-8', 04:45:43 INFO - 'LANGUAGE': 'en_US:en', 04:45:43 INFO - 'LOGNAME': 'cltbld', 04:45:43 INFO - 'MAIL': '/var/mail/cltbld', 04:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:43 INFO - 'MOZ_NO_REMOTE': '1', 04:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:43 INFO - 'NO_EM_RESTART': '1', 04:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:43 INFO - 'PWD': '/builds/slave/test', 04:45:43 INFO - 'SHELL': '/bin/bash', 04:45:43 INFO - 'SHLVL': '1', 04:45:43 INFO - 'TERM': 'linux', 04:45:43 INFO - 'TMOUT': '86400', 04:45:43 INFO - 'USER': 'cltbld', 04:45:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:43 INFO - '_': '/tools/buildbot/bin/python'} 04:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:43 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:45:43 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:45:43 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:45:43 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:45:43 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:45:43 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:45:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 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:45:46 INFO - Downloading docopt-0.6.1.tar.gz 04:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:46 INFO - Running setup.py install for blobuploader 04:45:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:46 INFO - Running setup.py install for requests 04:45:46 INFO - Running setup.py install for docopt 04:45:46 INFO - Successfully installed blobuploader requests docopt 04:45:46 INFO - Cleaning up... 04:45:46 INFO - Return code: 0 04:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:46 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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:46 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:45:46 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:45:46 INFO - Using env: {'DISPLAY': ':0', 04:45:46 INFO - 'HOME': '/home/cltbld', 04:45:46 INFO - 'LANG': 'en_US.UTF-8', 04:45:46 INFO - 'LANGUAGE': 'en_US:en', 04:45:46 INFO - 'LOGNAME': 'cltbld', 04:45:46 INFO - 'MAIL': '/var/mail/cltbld', 04:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:46 INFO - 'MOZ_NO_REMOTE': '1', 04:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:46 INFO - 'NO_EM_RESTART': '1', 04:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:46 INFO - 'PWD': '/builds/slave/test', 04:45:46 INFO - 'SHELL': '/bin/bash', 04:45:46 INFO - 'SHLVL': '1', 04:45:46 INFO - 'TERM': 'linux', 04:45:46 INFO - 'TMOUT': '86400', 04:45:46 INFO - 'USER': 'cltbld', 04:45:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:46 INFO - '_': '/tools/buildbot/bin/python'} 04:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:47 INFO - Running setup.py (path:/tmp/pip-vQjbSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:47 INFO - Running setup.py (path:/tmp/pip-OtkqhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:47 INFO - Running setup.py (path:/tmp/pip-7Ny2Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:47 INFO - Running setup.py (path:/tmp/pip-rJD9Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:47 INFO - Running setup.py (path:/tmp/pip-Nlvg2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:47 INFO - Running setup.py (path:/tmp/pip-hmDZqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:47 INFO - Running setup.py (path:/tmp/pip-Vdis85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:47 INFO - Running setup.py (path:/tmp/pip-9xQ75T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:47 INFO - Running setup.py (path:/tmp/pip-dvW1ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:47 INFO - Running setup.py (path:/tmp/pip-dZyXeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:47 INFO - Running setup.py (path:/tmp/pip-yApwHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:48 INFO - Running setup.py (path:/tmp/pip-xJKIxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:48 INFO - Running setup.py (path:/tmp/pip-VxROXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:48 INFO - Running setup.py (path:/tmp/pip-iTUFq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:48 INFO - Running setup.py (path:/tmp/pip-jYKZIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:48 INFO - Running setup.py (path:/tmp/pip-D9fczX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:48 INFO - Running setup.py (path:/tmp/pip-XC2ZkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:48 INFO - Running setup.py install for manifestparser 04:45:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Running setup.py install for mozcrash 04:45:48 INFO - Running setup.py install for mozdebug 04:45:48 INFO - Running setup.py install for mozdevice 04:45:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:48 INFO - Running setup.py install for mozfile 04:45:48 INFO - Running setup.py install for mozhttpd 04:45:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for mozinfo 04:45:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for mozInstall 04:45:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for mozleak 04:45:49 INFO - Running setup.py install for mozlog 04:45:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for moznetwork 04:45:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for mozprocess 04:45:49 INFO - Running setup.py install for mozprofile 04:45:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for mozrunner 04:45:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:49 INFO - Running setup.py install for mozscreenshot 04:45:50 INFO - Running setup.py install for moztest 04:45:50 INFO - Running setup.py install for mozversion 04:45:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:50 INFO - Cleaning up... 04:45:50 INFO - Return code: 0 04:45:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:50 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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:50 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:45:50 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:45:50 INFO - Using env: {'DISPLAY': ':0', 04:45:50 INFO - 'HOME': '/home/cltbld', 04:45:50 INFO - 'LANG': 'en_US.UTF-8', 04:45:50 INFO - 'LANGUAGE': 'en_US:en', 04:45:50 INFO - 'LOGNAME': 'cltbld', 04:45:50 INFO - 'MAIL': '/var/mail/cltbld', 04:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:50 INFO - 'MOZ_NO_REMOTE': '1', 04:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:50 INFO - 'NO_EM_RESTART': '1', 04:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:50 INFO - 'PWD': '/builds/slave/test', 04:45:50 INFO - 'SHELL': '/bin/bash', 04:45:50 INFO - 'SHLVL': '1', 04:45:50 INFO - 'TERM': 'linux', 04:45:50 INFO - 'TMOUT': '86400', 04:45:50 INFO - 'USER': 'cltbld', 04:45:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:50 INFO - '_': '/tools/buildbot/bin/python'} 04:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:50 INFO - Running setup.py (path:/tmp/pip-OPjt47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:50 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:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:50 INFO - Running setup.py (path:/tmp/pip-DzcGBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:51 INFO - Running setup.py (path:/tmp/pip-rOI7ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:51 INFO - Running setup.py (path:/tmp/pip-1B7iII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:51 INFO - Running setup.py (path:/tmp/pip-jgpriN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:51 INFO - Running setup.py (path:/tmp/pip-HOUvkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:51 INFO - Running setup.py (path:/tmp/pip-L1ObPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:51 INFO - Running setup.py (path:/tmp/pip-Y7vPrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:51 INFO - Running setup.py (path:/tmp/pip-2u8wt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:51 INFO - Running setup.py (path:/tmp/pip-fxQeoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:51 INFO - Running setup.py (path:/tmp/pip-iLQIYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:51 INFO - Running setup.py (path:/tmp/pip-PkbW0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:51 INFO - Running setup.py (path:/tmp/pip-l4FYei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:51 INFO - Running setup.py (path:/tmp/pip-dgNkju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:51 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:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:51 INFO - Running setup.py (path:/tmp/pip-81Pw_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:52 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:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:52 INFO - Running setup.py (path:/tmp/pip-BqI_Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:52 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:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:52 INFO - Running setup.py (path:/tmp/pip-p1RlQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:52 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:45:52 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:45:52 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:45:52 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:45:52 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:45:52 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:45:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45: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:45: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:45: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:45: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:45: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:45: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:45:54 INFO - Downloading blessings-1.6.tar.gz 04:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:54 INFO - Installing collected packages: blessings 04:45:54 INFO - Running setup.py install for blessings 04:45:54 INFO - Successfully installed blessings 04:45:54 INFO - Cleaning up... 04:45:54 INFO - Return code: 0 04:45:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:54 INFO - Reading from file tmpfile_stdout 04:45:54 INFO - Current package versions: 04:45:54 INFO - argparse == 1.2.1 04:45:54 INFO - blessings == 1.6 04:45:54 INFO - blobuploader == 1.2.4 04:45:54 INFO - docopt == 0.6.1 04:45:54 INFO - functools32 == 3.2.3-2 04:45:54 INFO - jsonschema == 2.5.1 04:45:54 INFO - manifestparser == 1.1 04:45:54 INFO - mozInstall == 1.12 04:45:54 INFO - mozcrash == 0.17 04:45:54 INFO - mozdebug == 0.1 04:45:54 INFO - mozdevice == 0.48 04:45:54 INFO - mozfile == 1.2 04:45:54 INFO - mozhttpd == 0.7 04:45:54 INFO - mozinfo == 0.9 04:45:54 INFO - mozleak == 0.1 04:45:54 INFO - mozlog == 3.2 04:45:54 INFO - moznetwork == 0.27 04:45:54 INFO - mozprocess == 0.23 04:45:54 INFO - mozprofile == 0.28 04:45:54 INFO - mozrunner == 6.12 04:45:54 INFO - mozscreenshot == 0.1 04:45:54 INFO - mozsystemmonitor == 0.3 04:45:54 INFO - moztest == 0.7 04:45:54 INFO - mozversion == 1.4 04:45:54 INFO - psutil == 3.1.1 04:45:54 INFO - requests == 1.2.3 04:45:54 INFO - wsgiref == 0.1.2 04:45:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:54 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:45:54 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:45:54 INFO - Using env: {'DISPLAY': ':0', 04:45:54 INFO - 'HOME': '/home/cltbld', 04:45:54 INFO - 'LANG': 'en_US.UTF-8', 04:45:54 INFO - 'LANGUAGE': 'en_US:en', 04:45:54 INFO - 'LOGNAME': 'cltbld', 04:45:54 INFO - 'MAIL': '/var/mail/cltbld', 04:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:54 INFO - 'MOZ_NO_REMOTE': '1', 04:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:54 INFO - 'NO_EM_RESTART': '1', 04:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:54 INFO - 'PWD': '/builds/slave/test', 04:45:54 INFO - 'SHELL': '/bin/bash', 04:45:54 INFO - 'SHLVL': '1', 04:45:54 INFO - 'TERM': 'linux', 04:45:54 INFO - 'TMOUT': '86400', 04:45:54 INFO - 'USER': 'cltbld', 04:45:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:54 INFO - '_': '/tools/buildbot/bin/python'} 04:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 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:45:54 INFO - Cleaning up... 04:45:54 INFO - Return code: 0 04:45:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:54 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:45:54 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:45:54 INFO - Using env: {'DISPLAY': ':0', 04:45:54 INFO - 'HOME': '/home/cltbld', 04:45:54 INFO - 'LANG': 'en_US.UTF-8', 04:45:54 INFO - 'LANGUAGE': 'en_US:en', 04:45:54 INFO - 'LOGNAME': 'cltbld', 04:45:54 INFO - 'MAIL': '/var/mail/cltbld', 04:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:54 INFO - 'MOZ_NO_REMOTE': '1', 04:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:54 INFO - 'NO_EM_RESTART': '1', 04:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:54 INFO - 'PWD': '/builds/slave/test', 04:45:54 INFO - 'SHELL': '/bin/bash', 04:45:54 INFO - 'SHLVL': '1', 04:45:54 INFO - 'TERM': 'linux', 04:45:54 INFO - 'TMOUT': '86400', 04:45:54 INFO - 'USER': 'cltbld', 04:45:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:54 INFO - '_': '/tools/buildbot/bin/python'} 04:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:54 INFO - Cleaning up... 04:45:54 INFO - Return code: 0 04:45:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:54 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 0x7fb663891f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, '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': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', '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:45:54 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:45:54 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:45:54 INFO - Using env: {'DISPLAY': ':0', 04:45:54 INFO - 'HOME': '/home/cltbld', 04:45:54 INFO - 'LANG': 'en_US.UTF-8', 04:45:54 INFO - 'LANGUAGE': 'en_US:en', 04:45:54 INFO - 'LOGNAME': 'cltbld', 04:45:54 INFO - 'MAIL': '/var/mail/cltbld', 04:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:54 INFO - 'MOZ_NO_REMOTE': '1', 04:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:54 INFO - 'NO_EM_RESTART': '1', 04:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:54 INFO - 'PWD': '/builds/slave/test', 04:45:54 INFO - 'SHELL': '/bin/bash', 04:45:54 INFO - 'SHLVL': '1', 04:45:54 INFO - 'TERM': 'linux', 04:45:54 INFO - 'TMOUT': '86400', 04:45:54 INFO - 'USER': 'cltbld', 04:45:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:54 INFO - '_': '/tools/buildbot/bin/python'} 04:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:55 INFO - Downloading/unpacking flake8 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:45:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:45:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:45:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:45:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:45:57 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:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:57 INFO - no previously-included directories found matching 'docs/_build' 04:45:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:45:57 INFO - Running setup.py install for pep8 04:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:57 INFO - no previously-included directories found matching 'docs/_build' 04:45:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:45:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:45:58 INFO - Cleaning up... 04:45:58 INFO - Return code: 0 04:45:58 INFO - Running post-action listener: _resource_record_post_action 04:45:58 INFO - Running post-action listener: _start_resource_monitoring 04:45:58 INFO - Starting resource monitoring. 04:45:58 INFO - ##### 04:45:58 INFO - ##### Finished create-virtualenv step (success) 04:45:58 INFO - ##### 04:45:58 INFO - ##### 04:45:58 INFO - ##### Running install step. 04:45:58 INFO - ##### 04:45:58 INFO - Running pre-action listener: _resource_record_pre_action 04:45:58 INFO - Running main action method: install 04:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:58 INFO - Reading from file tmpfile_stdout 04:45:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:58 INFO - Reading from file tmpfile_stdout 04:45:58 INFO - Output received: 04:45:58 INFO - Usage: mozinstall [options] installer 04:45:58 INFO - Options: 04:45:58 INFO - -h, --help show this help message and exit 04:45:58 INFO - -d DEST, --destination=DEST 04:45:58 INFO - Directory to install application into. [default: 04:45:58 INFO - "/builds/slave/test"] 04:45:58 INFO - --app=APP Application being installed. [default: firefox] 04:45:58 INFO - mkdir: /builds/slave/test/build/application 04:45:58 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:45:58 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:46:14 INFO - Reading from file tmpfile_stdout 04:46:14 INFO - Output received: 04:46:14 INFO - /builds/slave/test/build/application/firefox/firefox 04:46:14 INFO - Running post-action listener: _resource_record_post_action 04:46:14 INFO - ##### 04:46:14 INFO - ##### Finished install step (success) 04:46:14 INFO - ##### 04:46:14 INFO - ##### 04:46:14 INFO - ##### Running run-tests step. 04:46:14 INFO - ##### 04:46:14 INFO - Running pre-action listener: _resource_record_pre_action 04:46:14 INFO - Running main action method: run_tests 04:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:46:14 INFO - Python 2.7.3 04:46:14 INFO - Return code: 0 04:46:14 INFO - grabbing minidump binary from tooltool 04:46: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:46:14 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 0x255c1c0>, '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 0x255d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:46:14 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:46:14 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:46:14 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:46:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:46:14 INFO - Return code: 0 04:46:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:46:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:46:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:46:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:46:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:46:15 INFO - Return code: 0 04:46:15 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:46:15 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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:46:15 INFO - Using env: {'DISPLAY': ':0', 04:46:15 INFO - 'HOME': '/home/cltbld', 04:46:15 INFO - 'LANG': 'en_US.UTF-8', 04:46:15 INFO - 'LANGUAGE': 'en_US:en', 04:46:15 INFO - 'LOGNAME': 'cltbld', 04:46:15 INFO - 'MAIL': '/var/mail/cltbld', 04:46:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:15 INFO - 'MOZ_NO_REMOTE': '1', 04:46:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:15 INFO - 'NO_EM_RESTART': '1', 04:46:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:15 INFO - 'PWD': '/builds/slave/test', 04:46:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:15 INFO - 'SHELL': '/bin/bash', 04:46:15 INFO - 'SHLVL': '1', 04:46:15 INFO - 'TERM': 'linux', 04:46:15 INFO - 'TMOUT': '86400', 04:46:15 INFO - 'USER': 'cltbld', 04:46:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1469446835.232348-903693951', 04:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:15 INFO - '_': '/tools/buildbot/bin/python'} 04:46:15 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/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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:46:15 INFO - mozversion application_buildid: 20160725020629 04:46:15 INFO - mozversion application_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 04:46:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:46:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:46:15 INFO - mozversion application_name: Firefox 04:46:15 INFO - mozversion application_remotingname: firefox-dev 04:46:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:46:15 INFO - mozversion application_vendor: Mozilla 04:46:15 INFO - mozversion application_version: 49.0a2 04:46:15 INFO - mozversion platform_buildid: 20160725020629 04:46:15 INFO - mozversion platform_changeset: 517663b29d7ffc2ce91f90dc7beaac4fa35e52e5 04:46:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:46:15 INFO - mozversion platform_version: 49.0a2 04:46:15 INFO - using testdate: 1469447175 04:46:15 INFO - actual date: 1469447175 04:46:15 INFO - starting webserver on 'localhost:35507' 04:46:15 INFO - SUITE-START | Running 2 tests 04:46:15 INFO - TEST-START | dromaeo_css 04:46:15 INFO - operating with platform_type : linux_ 04:46:15 INFO - Initialising browser for dromaeo_css test... 04:46:15 INFO - TEST-INFO | started process 29534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVy2Jlw/profile http://localhost:35507/getInfo.html) 04:46:19 INFO - PROCESS | 29534 | __metrics Screen width/height:1600/1200 04:46:19 INFO - PROCESS | 29534 | colorDepth:24 04:46:19 INFO - PROCESS | 29534 | Browser inner width/height: 1024/697 04:46:19 INFO - PROCESS | 29534 | __metrics 04:46:20 ERROR - PROCESS | 29534 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:46:21 INFO - TEST-INFO | 29534: exit 0 04:46:21 INFO - Browser initialized. 04:46:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:46:21 INFO - TEST-INFO | started process 29666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVy2Jlw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:33 INFO - PROCESS | 29666 | RSS: Main: 156172288 04:46:33 INFO - PROCESS | 29666 | 04:47:23 INFO - PROCESS | 29666 | 1469447243042 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:49:31 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:35507/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35507/tests/dromaeo/cssquery-ext.html) 04:49:32 INFO - PROCESS | 29666 | RSS: Main: 159670272 04:49:32 INFO - PROCESS | 29666 | 04:52:34 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:35507/tests/dromaeo/cssquery-ext.html (next: http://localhost:35507/tests/dromaeo/cssquery-jquery.html) 04:52:34 INFO - PROCESS | 29666 | RSS: Main: 158060544 04:52:34 INFO - PROCESS | 29666 | 04:55:36 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:35507/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35507/tests/dromaeo/cssquery-mootools.html) 04:55:37 INFO - PROCESS | 29666 | RSS: Main: 157470720 04:55:37 INFO - PROCESS | 29666 | 04:58:38 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:35507/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35507/tests/dromaeo/cssquery-prototype.html) 04:58:39 INFO - PROCESS | 29666 | RSS: Main: 157081600 04:58:39 INFO - PROCESS | 29666 | 05:01:41 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:35507/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35507/tests/dromaeo/cssquery-yui.html) 05:01:42 INFO - PROCESS | 29666 | RSS: Main: 159670272 05:01:42 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | Cycle 1(1): loaded http://localhost:35507/tests/dromaeo/cssquery-yui.html (next: http://localhost:35507/tests/dromaeo/cssquery-dojo.html) 05:04:44 INFO - PROCESS | 29666 | RSS: Main: 159428608 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | __start_tp_report 05:04:44 INFO - PROCESS | 29666 | _x_x_mozilla_page_load 05:04:44 INFO - PROCESS | 29666 | _x_x_mozilla_page_load_details 05:04:44 INFO - PROCESS | 29666 | |i|pagename|runs| 05:04:44 INFO - PROCESS | 29666 | |0;dojo.html;3335.2995870867117;3394.0496660934914;3406.437937740272;3424.075499615104;3429.639887811778;5614.635048721831;5621.690807005613;5653.717314134287;5661.547076233902;5723.370429252779;5725.997950358681;5732.79935202268;5757.856053598662;5774.682392468412;5775.913361299574;5150.3047088643025;5165.81919632813;5229;5263.34208223972;5264.105102132647;5145.073886700392;5159.613029022819;5268.104422248227;5277.656952298107;5278.261043453919;5228.555572776299;5231.5814734821315;5243.764030618631;5273.789048438058;5279.2872962150195;5243.9213411798855;5248.160294352885;5316.973415132899;5322.7072511011875;5330.653507522037;5190.688558686491;5232.529072383504;5283.418823929364;5293.682379057269;5325.680459172462;5427.968685949657;5467.07059799831;5502.339719233718;5569.136783798518;5616.691081990489;6094.146819445281;6125.724342404558;6135.141080248769;6137.171481849938;6145.170401995762;5994.520438364921;6171.105189747506;6184.165137706442;6185.56701030928;6193.597416167935;5607.607467477278;5616.831495055155;5666.150077488369;5686.147077938343;5717.456841600041;6166.414190651881;6197.225346831646;6207.099970504342;6210.099535567318;6250.843728906813;5730.054541000772;5871.119332100134;5992.041273396236;5997.190379298826;6016.8796624068145;6036.185115009417;6123.08153776937;6152.323244443108;6155.538334624921;6158.630482171084;6043.637381757108;6047.637141771508;6101.908471372933;6112.572119951649;6117.318435754137;5918;5998.610090344201;6033.849153771103;6044.546659000593;6130.111133885562;4704.9529504704515;4708.364370809965;4709.105269998689;4731.148393289241;4731.361266229083;4180.226658068206;4188.979055104705;4201.138766552849;4202.642775364067;4231.830726770956;5811.709414529257;5868.178455016301;5897.587168898136;5913.053911374245;5917.023691091008;5931.169636250928;6030.095485677183;6121.269493298861;6127.953177891157;6217.4715149212825;5819.709014549256;5879.118132280107;5882.705864706833;5894.204282421904;5896.380880007623;5019.874503137451;5140.588752899759;5168.819091331786;5205.401378841406;5244.9737751310995;6336.6831658416895;6374.171357723466;6399.2640846303275;6401.871962560723;6419.422251997343;5864.530837532901;6178.505719542426;6193.040078787795;6196.411340922605;6207.596506227081;6211.0372892201785;6224.253089629274;6305.148804911279;6391.073294372197;6395.744170233139;5998.550108741949;6007.279126504847;6015.909761353496;6019.6756713522955;6019.729112189874;5946.583739138218;6059.909101363572;6111.252045622946;6123.343628574382;6138.907916381168;5929.110633405024;6042.879142417215;6060.848478787889;6068.939310606837;6112.358202388863;6003.8198854034445;6009.759609615567;6044.9395506044375;6053.4551890330085;6063.6664983426335;5670.829875103754;5774.1916131740745;5815.069588865761;5906.202662640489;5923.851903702442;6006.699665016819;6033.728482218398;6048.909266361096;6061.969690151521;6079.452849243589;5884.47039766423;5889;5893.292804863444;5898.469137777621;5919.526437885045 05:04:44 INFO - PROCESS | 29666 | |1;ext.html;606.5753972219447;650.9479241660667;664.8470851704108;668.3049628386478;669.2069897171849;44671;46538.3019254711;46542.767286163566;50446;50480.747596261965;44822.55177448224;45336.773316133455;45362.77318613402;45413.31880021794;45483;8536.48781073136;8837.38138330317;8849.115088491131;8851.468911865277;8859.822803543926;8785.209331160195;8851.468911865277;8854;8855.690050848221;8868.467891926504;8809;8815.867761983576;8855.867161992543;8864.113588641148;8899.154580314893;8828.646854125827;8837.646494140226;8881;8889.466632002068;8902.955485222597;8768.605412756377;8852;8874.911250887537;8885.378023538355;8897.243734282594;42003.57996420058;42415.57584424147;42449.787751061354;42561.14877702429;42599;3651.4887915691825;3819.52255968004;3841.19334939663;3878.8836334909997;3942.4874766280486;34171.82914085439;34385.82807085974;34403.655963440295;34452;35674.64325356765;4665.650076244296;4834.685745426571;4844;4872.196087645534;4913.926291105637;386080;387550;387843;387900.0604996985;388642;37466.06334841596;38454;68075.3192468069;68610;68769.65615171893;39801.20397592032;39805.80097099496;39853.40219896704;39956.40065399021;39981.40027899584;15651.139187344805;15677.686446271238;15687.98028128168;15714.057156570643;15778.526644200692;14664.120152790867;14790.408383664748;14833.184174870486;14873;14876.553703388916;8995.775105622412;9093.545322733837;9106.134917182857;9149.176574108362;9162.267018638493;3424.417848965682;3454.0674018014997;3484.738644601665;3493;3510.613832478425;1103.2938919091628;1129.6159305836056;1141.2296699727651;1162.3723189477757;1225.2770865189582;33689.66310336865;34628.65371346254;34802.651973480446;34864.30271394558;35305;1157.7279339355246;1186.1044911092242;1204.6989251608243;1206.595790410205;1292.75437666843;17634.206460709298;18134.818651813577;18270.54323641893;18285.908570457064;18355;632637;644708;649803;660762;664163;58126.709366452895;58238;58510.414895850496;58546;58708.41291587029;1444.8410674825761;1447.6887469194173;1448.0298200205887;1451.992740036293;1489.3393865839512;30654.693453065185;32733.836330818194;32918.50622240716;33195.66804331926;33326.16684582808;51385;52044.21933671074;52162.47837521728;52174;52400.47599523956;302320;302762;380772;381304;381527;29286;30023.249418764706;30150.698493015665;30179.547306789977;30229.697703022688;48141;48992.81434741939;49037;49068.263976041104;49714.50285497099;39539.80230098831;39962.20075598414;40918.83157240522;41745;41861.1627767449;39956.600433995285;40141;40480.3927941087;41250.1749965005;42122.7893860541;41939.580604193565;42666;42744;42905.78547107244;42932.35601466043;35456.82271588626;35818.64181358153;36386;36416.27167456583;36581.81709091544;28108.578371324038;28531.10162390805;28929.710702892702;29187.416251675273;29301.560476593295 05:04:44 INFO - PROCESS | 29666 | |2;jquery.html;391.75123796389283;396.69058134654944;404.6883899397464;408.8303354108044;419.1282133163021;14869.55391338259;18140.546486337847;19771.703424448628;19799.703004454946;20578.69131963018;18177.272909083655;18460.81539184611;18741.812581874176;20180.59638807223;20208.69686954697;5573.164025396182;5677.574181936361;5869.50109240715;5871.970640146793;5878.911816322759;5336.439673834249;5616.466435688603;5802;5807.854803629922;5821.27234095738;5638.351589567212;5643.774249030034;5651.32184137902;5660.377358490563;5671.149327600851;5482.5613950884035;5788.189653448541;5812.244408226925;5871.706414679292;5882.911756323659;5475.945240547583;5634.183043458716;5648.745806438679;5660.150977353389;5669.603127781057;13112.934435327857;13127.474901003949;16872.493825185265;23741.88129059361;23900.28299151028;2308.4921317310163;2335.988320058406;2396.364963284731;2673.358393985449;2961.1098929575105;10214.795704085951;10620.681379558626;10642.946785266024;10829.404382758945;10875.45622718861;1968.22255209193;2041.7039529268172;2113.429374069008;2149.720536330283;2168.6746987951774;63314.68342658303;81247.5937620314;81341.59329203375;81668.59165704134;83432;11001.17491188164;11230.550777968952;11460.312381256985;11674.94162529182;11750.059995200363;16345.754813677804;16355.509334719978;16411.91794041022;16492.752608710878;16526.752098718527;8586.441881277697;8819.955900220459;8823.426477278956;8894.777630559287;8979;8446.155384461505;8548.187922147386;8574.442661227;8586.570671466401;8716.259117974916;4853.126437241331;4901.411830580353;4912.189488734391;4984.451710311862;5019.824306149268;2021.9393418197478;2032.2582257475915;2036.5417780999157;2088.2691058129535;2138.134055707441;487.1353347807599;500.5395036566295;925.2967744514218;1017.8269694152012;1159.243745725227;12044.988752811798;12410.5656302029;12461.1900226485;12831;12856.228626282265;492.30339070215246;513.117438006628;515.6467819543625;516.49641599441;517.751479289943;6715.3620406061345;6893.0694356261265;6911.516193866481;6927.896081558781;6948.826279342956;545608;549803;553157;553977;556146;99775.50112249538;100451;100702;101916.49041754892;103135;514.4135685318739;520.3417676639054;525.3669328459198;526.0504788856075;526.7866514061811;11740.41297935117;11792.70518237051;11926.880731192578;11953.701157471132;11978.76042479163;38673.613263867;40438.59561404349;42252.57747422486;43278;44999;59657.40342596518;59837;60403.395966039774;61481;62362.68818655878;7737.613119343898;8082.595870206349;8092.595370231347;8583.18459746323;8941.418807777474;9994.800103998024;13335.466581337027;13369.866301337252;13455;13565.660858478617;11478.598249061577;11705.180637355303;11834.171607987359;11882.405879706153;11952.804719528325;11205.71985700364;11323.716907077389;11457;11460.770784584094;11541.422928853692;6556.213254409501;8923;11687.824682629938;11808.881911180779;11887.821682674594;7322.231165727522;7801.45389822707;8169.877451838108;8211.71259005932;8257.463264887763;11309.547618095514;11608.477618507019;11639.127065470293;11676.766464670489;11682.415879206175 05:04:44 INFO - PROCESS | 29666 | |3;mootools.html;1557.4626753769949;1559.539935718963;1743.8343357381045;1810.1039985207324;1844.880082794619;7715.768526944201;8618.525981071038;8746.518941458226;9150.49672268025;9216.262698984083;8612.870806937884;8815.735527934172;8887.555622218895;8950.82098358034;8978.416402933804;2222.3888430681573;2272.4091736148557;2276;2276.430892276931;2278.6354183330673;2354.82338824588;2366.349253955159;2377.1561095811;2378.4410663494064;2386.988065059681;2386.713594368678;2395.940101497468;2403.3871362802547;2405.1822380390663;2420.98318706143;2281.9657705134437;2288.725352957639;2301.3326135420707;2305.8847057647135;2311.7688231176917;2279.8290128240446;2292.885355732207;2304.481491664379;2311.861288322706;2314.8032417244553;8955.552222388855;8957.731268061969;8961.731148065503;8972.147645973622;9026.54867256641;5271.604629652753;5365.865853353658;5403.324584426947;5403.7027963462;5407.675539467645;3431.365197438482;3528.4001719707453;3560.181158333598;3565.2691198304287;3637.7089832813313;1232.4084439469104;1259;1272.2112290380023;1288.1948782011243;1288.6778305423645;12555.93722031384;12629;12653.114282000264;12693.11148219625;12777.488900443972;4526.343680166357;4611.654125940501;4644.419447569054;4656.8125128092115;4723.574878260973;10736;10751.569937202581;10875.238733288594;10880.564777408816;10891.237613366988;5342.358916929993;5388.164834450667;5392.973035134799;5399.460053994648;5427.6472029317965;4382.101669157879;4862.222044472867;4925.926111108336;5016.44819069902;5022.271770593316;4132.648724858421;4195.328747400401;4210.6841986850495;4242.490901091889;4249.128928569636;1326.635175326793;1345.031577264368;1351.6215459671307;1355.1259437662652;1359.823222981026;957.707899090784;1004.9196064314838;1029.6499190275342;1045.749020235138;1045.9790804183874;6221;6289.182406287154;6299.244090709144;6355.237371515448;6452.967525195946;483.941926968766;485.7255650557494;487.6440198654931;490.37232342601527;499.8700337912169;4457.531959144308;4505.504394516601;4512.368268442421;4514.503404625489;4535.115652447741;11144.275622084539;11497.137714671266;11546.538138474367;11551.884481155248;11579.536818527165;10355.844662330072;11295.943520282346;11393.487293071832;11483.081353491702;11503;8228.958855205805;8621.137886211329;8691.087435819149;8702.608382622671;8705.695300664447;6355.237371515448;6581.3418658133805;6600.8349791255605;6627.768028118992;6681.198256209286;10464.267501274837;10689.732756681145;10762.569497220024;10801.621943231949;10852.728681782703;10759.408232546972;10840.891591084304;10906.890931090587;10933.56265749361;10946.507407166855;7175.067241258603;8014.919850801417;8158.3065439438315;8236.423450358418;8263.95868020656;9116.589753461243;9136.314776391664;9136.543172841464;9140.63437462494;9214.769630759016;8091.1504292048485;8284.71003514874;8345.332373410234;8452.788680282796;8456.577171141542;8271.875921861298;8296.502209867427;8313.41806073569;8347.12355202695;8389;7443.81390465221;7575.053118360205;7576.621168941641;7611.619419028915;7617.771466856003;5527.50757295536;5644.8024319148635;5652.689102099424;5723.084306510938;5793.91309130355;5639.351474580476;5702.600817942704;5707.714614269353;5717.485426311652;5752.597318187687 05:04:44 INFO - PROCESS | 29666 | |4;prototype.html;345.6612519730664;348.65483171660054;365.1419164962339;365.9853605855766;370.2280744647408;5555.222268882349;5577.219189313494;5594.440555944404;5635.295588051494;5638.520725738312;5517.317218248432;5538.556915446765;5547;5569.192467092269;5580.888382232363;4218.704690671654;4379.167958087969;4388.780560971954;4389.341598760179;4407.162639098577;4340.52254252032;4341.6092551670345;4372.825086996516;4414.09511050234;4437.733735975852;4343.305071188611;4386.824527018932;4433.578810013044;4439.178751930887;4441.422615060038;4291.549387314334;4367.889569204039;4380.693351465398;4381.816909434467;4406.449193850769;3824.8852534424013;3828.1386687995255;3865.8067096645336;3868.7233213039913;3874.651281384689;5399.514043736082;5417.6207665463435;5443.972780136113;5444.346678398578;5494.560435165177;4924.729139897304;4978.327925730016;4985.052839960432;4986.850394488171;5042.974785126051;5793.188953546507;5824.213731146283;5849.853753656193;5856.472917437451;5899.941000589982;4253.553376895412;4262;4264.616184543375;4268.189044081614;4277.550857160016;5912.6156799808305;5994.820155395345;6005.399460054047;6100.298465676459;6102.145699602059;4196.706230563892;4253.957460425418;4265.722728022669;4266.914661706811;4275.722078064916;4282.8715138545895;4308.332208507623;4314.956850431456;4336.392904993303;4339.609435150788;4868.196747536616;4945;4947.381577302837;4986.301917731521;4999.0501804657;5884.499817515559;5889.764409423661;5895.41045895407;5916.171735956969;5939.822195125587;1486.3757221966584;1492.8581784730434;1509.5018643847504;1519.840416756247;1520.0423733048108;950.4202436513721;978.7504186432415;990.6829814459448;999.6151481679606;999.8550210219478;5148.279240906276;5174.663646862942;5176.945602094707;5196.870078248074;5198.32421785173;5372.52255629705;5416.756245968941;5425.484578964992;5427.4301198373605;5432.13085906261;4822.432709369469;5046.870940017213;5146.224552529371;5170.741462926839;5206.609504287194;2869.397426540408;2878.2372671242138;2885.2354126156583;2897.8261304321386;2900.506913824655;5586.13414920688;5615.241942337732;5619.213310136584;5635.436456354331;5664.461876121762;5082.771275292621;5449.700266485302;5458.317710286215;5467.4532546745;5551.916721249185;5575.749091290902;5623.8875222496135;5646.20953066571;5648.406917273709;5690.800821971294;5133.383993920754;5338.412774594869;5367.463253674601;5389.7035663038905;5401.783928642811;5318.7074710891275;5331.946680533145;5364.570834333322;5396.21754845553;5402.8649283766645;6159.722812473539;6310.580119473082;6355.90466142999;6410.5192110592825;6466.902996454963;4334.2631752602765;4344.283193273074;4402.933955990727;4411.2721400968485;4417.160739459492;6091.634501929899;6202.782902598387;6202.937970620236;6203.193584833943;6240.656763878031;5942.405759424023;5952.76188952437;5992.490638295793;6000.759969601167;6018.668973206516;5881.705914704333;5960.314563825043;5994.910076348771;5995.5803093783015;6020.524971382039;5746.310442746897;5913.526917846476;5914.763409463573;5921.3190483094995;5939.703014849154;5959.761609535743;5988.335190840035;5991.880162396815;6016.518678505797;6037.516998640011;5622.064554811566;5884.352721200579;5896.528277737685;5896.941030589811;5922.970385148046 05:04:44 INFO - PROCESS | 29666 | |5;yui.html;744.9031625888633;774.0865778381511;852.7995920958575;889.4040992535001;910.9544522773859;15968.600784980381;17021.40425085122;17516.474505764814;17563.91218043908;17593.91203043983;15925.44260950867;16193.35226590938;16215.83784162158;16227.756583651255;16238.918805405987;711.2567367101378;833.9291160251356;855.6620135046653;860.8794768732382;865.5369377383101;858.3862538285125;858.7166235142388;866.7096522664915;867.0765634599163;868.4008034456205;908.900020997693;909.749818799832;911.567005672307;913.2693844924067;913.7350168451142;905.0768216419282;907.8638204269347;907.8955920069144;908.4322298563364;908.9181973622373;663.2008429842028;664.5580688841962;667.5727534378002;669.0599707411046;669.1100835888257;13184.274864882427;13203.339833008311;13214.537491187859;13252.801207981887;13282.070255082148;15670.686586268212;16177.110258935754;16308;16518.339266429328;16738;12558.372081395984;12838.293893835835;12965.481380744759;12977.935110324388;13120.409581568852;4141.672111025317;4227.556106608823;4253.851115210953;4263.872083837458;4266.8293268269545;77906.61046694787;78162.60918695427;78236.60881695613;81349;82690.58654706748;12722;12776.936115319364;12790.552330668383;12818.61544153677;12865.2924089176;24156.516869662508;24317.392065198157;24444;24927.376815579755;25204.369890752878;8193.877091843628;8345.499270043816;8382.622781974826;8966.237869781142;9385.38994965325;5020.2720605511995;5060.291559181717;5090.10923088458;5146.716930568779;5228.137357336073;3656.8720094796554;3796.3925771876366;3801.7338786284695;3806.5812760596314;3811.1805961718364;583.2388732703778;633.7274971762187;641.0864518061743;644.7195469970578;644.8097811145723;704.3801454719916;711.6797441151502;727.6361819090455;763.0881097088925;771.9073711154585;9976;10278.794424111476;10399;10588.258821882548;10622.893771062345;696.314130581377;700.9905735740517;707.4729326651677;757.837065031021;767.4321002458253;4939.777710003059;5010.098182327143;5030.647854650139;5054.898902021939;5069.290299358093;96167.51916240514;114082;116265;118805.40597296959;119274.4036279813;61716.38283617106;63100.36899631037;77096;78033.21966780373;97987.51006244923;86997;88886.55556722175;91521;92310.53844730734;92546.07453925509;9355.953220233856;9451.149396554343;9490.478023708762;9505.619775208914;9593.952030240083;51140.74429627828;52042.21936670877;52929.735351323;53413.465865342405;54180.458195417545;69994;77323.61338193498;78090.6095469519;79899.60050199712;81435;11759.353235572125;11806.645800625995;11835.28988260707;11947;12454.029421170639;13418.194908305533;13528.661783455098;13530.120542164728;13565.186088834702;13622.523211687543;12651.746965060831;12754.808677870025;12773.445310938036;12796.936015320236;12898.41957111951;12410.255384676948;12447.190932589352;12519.687007824878;12809;13163.53927612529;11938.28370297785;12132.75734485323;12181.939090304491;12234.816477752664;12253.203541769757;10340.53467593945;10639.308444951053;10729.517171727135;10786.191035672513;10838.512266948164;10649.361038337414;10807.783844323227;10822.40476773785;10987.39569323695;11080.778384432428 05:04:44 INFO - PROCESS | 29666 | __end_tp_report 05:04:44 INFO - PROCESS | 29666 | __start_cc_report 05:04:44 INFO - PROCESS | 29666 | _x_x_mozilla_cycle_collect,344 05:04:44 INFO - PROCESS | 29666 | __end_cc_report 05:04:44 INFO - PROCESS | 29666 | __startTimestamp1469448284725__endTimestamp 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | ------- Summary: start ------- 05:04:44 INFO - PROCESS | 29666 | Number of tests: 6 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | [#0] dojo.html Cycles:165 Average:5682.71 Median:5898.47 stddev:628.56 (10.7%) stddev-sans-first:602.91 05:04:44 INFO - PROCESS | 29666 | Values: 3335.3 3394.0 3406.4 3424.1 3429.6 5614.6 5621.7 5653.7 5661.5 5723.4 5726.0 5732.8 5757.9 5774.7 5775.9 5150.3 5165.8 5229.0 5263.3 5264.1 5145.1 5159.6 5268.1 5277.7 5278.3 5228.6 5231.6 5243.8 5273.8 5279.3 5243.9 5248.2 5317.0 5322.7 5330.7 5190.7 5232.5 5283.4 5293.7 5325.7 5428.0 5467.1 5502.3 5569.1 5616.7 6094.1 6125.7 6135.1 6137.2 6145.2 5994.5 6171.1 6184.2 6185.6 6193.6 5607.6 5616.8 5666.2 5686.1 5717.5 6166.4 6197.2 6207.1 6210.1 6250.8 5730.1 5871.1 5992.0 5997.2 6016.9 6036.2 6123.1 6152.3 6155.5 6158.6 6043.6 6047.6 6101.9 6112.6 6117.3 5918.0 5998.6 6033.8 6044.5 6130.1 4705.0 4708.4 4709.1 4731.1 4731.4 4180.2 4189.0 4201.1 4202.6 4231.8 5811.7 5868.2 5897.6 5913.1 5917.0 5931.2 6030.1 6121.3 6128.0 6217.5 5819.7 5879.1 5882.7 5894.2 5896.4 5019.9 5140.6 5168.8 5205.4 5245.0 6336.7 6374.2 6399.3 6401.9 6419.4 5864.5 6178.5 6193.0 6196.4 6207.6 6211.0 6224.3 6305.1 6391.1 6395.7 5998.6 6007.3 6015.9 6019.7 6019.7 5946.6 6059.9 6111.3 6123.3 6138.9 5929.1 6042.9 6060.8 6068.9 6112.4 6003.8 6009.8 6044.9 6053.5 6063.7 5670.8 5774.2 5815.1 5906.2 5923.9 6006.7 6033.7 6048.9 6062.0 6079.5 5884.5 5889.0 5893.3 5898.5 5919.5 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | [#1] ext.html Cycles:180 Average:61620.05 Median:40310.70 stddev:128714.86 (319.3%) stddev-sans-first:128994.42 05:04:44 INFO - PROCESS | 29666 | Values: 606.6 650.9 664.8 668.3 669.2 44671.0 46538.3 46542.8 50446.0 50480.7 44822.6 45336.8 45362.8 45413.3 45483.0 8536.5 8837.4 8849.1 8851.5 8859.8 8785.2 8851.5 8854.0 8855.7 8868.5 8809.0 8815.9 8855.9 8864.1 8899.2 8828.6 8837.6 8881.0 8889.5 8903.0 8768.6 8852.0 8874.9 8885.4 8897.2 42003.6 42415.6 42449.8 42561.1 42599.0 3651.5 3819.5 3841.2 3878.9 3942.5 34171.8 34385.8 34403.7 34452.0 35674.6 4665.7 4834.7 4844.0 4872.2 4913.9 386080.0 387550.0 387843.0 387900.1 388642.0 37466.1 38454.0 68075.3 68610.0 68769.7 39801.2 39805.8 39853.4 39956.4 39981.4 15651.1 15677.7 15688.0 15714.1 15778.5 14664.1 14790.4 14833.2 14873.0 14876.6 8995.8 9093.5 9106.1 9149.2 9162.3 3424.4 3454.1 3484.7 3493.0 3510.6 1103.3 1129.6 1141.2 1162.4 1225.3 33689.7 34628.7 34802.7 34864.3 35305.0 1157.7 1186.1 1204.7 1206.6 1292.8 17634.2 18134.8 18270.5 18285.9 18355.0 632637.0 644708.0 649803.0 660762.0 664163.0 58126.7 58238.0 58510.4 58546.0 58708.4 1444.8 1447.7 1448.0 1452.0 1489.3 30654.7 32733.8 32918.5 33195.7 33326.2 51385.0 52044.2 52162.5 52174.0 52400.5 302320.0 302762.0 380772.0 381304.0 381527.0 29286.0 30023.2 30150.7 30179.5 30229.7 48141.0 48992.8 49037.0 49068.3 49714.5 39539.8 39962.2 40918.8 41745.0 41861.2 39956.6 40141.0 40480.4 41250.2 42122.8 41939.6 42666.0 42744.0 42905.8 42932.4 35456.8 35818.6 36386.0 36416.3 36581.8 28108.6 28531.1 28929.7 29187.4 29301.6 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | [#2] jquery.html Cycles:180 Average:30366.21 Median:42765.29 stddev:90959.04 (212.7%) stddev-sans-first:91186.35 05:04:44 INFO - PROCESS | 29666 | Values: 391.8 396.7 404.7 408.8 419.1 14869.6 18140.5 19771.7 19799.7 20578.7 18177.3 18460.8 18741.8 20180.6 20208.7 5573.2 5677.6 5869.5 5872.0 5878.9 5336.4 5616.5 5802.0 5807.9 5821.3 5638.4 5643.8 5651.3 5660.4 5671.1 5482.6 5788.2 5812.2 5871.7 5882.9 5475.9 5634.2 5648.7 5660.2 5669.6 13112.9 13127.5 16872.5 23741.9 23900.3 2308.5 2336.0 2396.4 2673.4 2961.1 10214.8 10620.7 10642.9 10829.4 10875.5 1968.2 2041.7 2113.4 2149.7 2168.7 63314.7 81247.6 81341.6 81668.6 83432.0 11001.2 11230.6 11460.3 11674.9 11750.1 16345.8 16355.5 16411.9 16492.8 16526.8 8586.4 8820.0 8823.4 8894.8 8979.0 8446.2 8548.2 8574.4 8586.6 8716.3 4853.1 4901.4 4912.2 4984.5 5019.8 2021.9 2032.3 2036.5 2088.3 2138.1 487.1 500.5 925.3 1017.8 1159.2 12045.0 12410.6 12461.2 12831.0 12856.2 492.3 513.1 515.6 516.5 517.8 6715.4 6893.1 6911.5 6927.9 6948.8 545608.0 549803.0 553157.0 553977.0 556146.0 99775.5 100451.0 100702.0 101916.5 103135.0 514.4 520.3 525.4 526.1 526.8 11740.4 11792.7 11926.9 11953.7 11978.8 38673.6 40438.6 42252.6 43278.0 44999.0 59657.4 59837.0 60403.4 61481.0 62362.7 7737.6 8082.6 8092.6 8583.2 8941.4 9994.8 13335.5 13369.9 13455.0 13565.7 11478.6 11705.2 11834.2 11882.4 11952.8 11205.7 11323.7 11457.0 11460.8 11541.4 6556.2 8923.0 11687.8 11808.9 11887.8 7322.2 7801.5 8169.9 8211.7 8257.5 11309.5 11608.5 11639.1 11676.8 11682.4 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | [#3] mootools.html Cycles:180 Average:6066.86 Median:4573.38 stddev:3468.00 (75.8%) stddev-sans-first:3461.17 05:04:44 INFO - PROCESS | 29666 | Values: 1557.5 1559.5 1743.8 1810.1 1844.9 7715.8 8618.5 8746.5 9150.5 9216.3 8612.9 8815.7 8887.6 8950.8 8978.4 2222.4 2272.4 2276.0 2276.4 2278.6 2354.8 2366.3 2377.2 2378.4 2387.0 2386.7 2395.9 2403.4 2405.2 2421.0 2282.0 2288.7 2301.3 2305.9 2311.8 2279.8 2292.9 2304.5 2311.9 2314.8 8955.6 8957.7 8961.7 8972.1 9026.5 5271.6 5365.9 5403.3 5403.7 5407.7 3431.4 3528.4 3560.2 3565.3 3637.7 1232.4 1259.0 1272.2 1288.2 1288.7 12555.9 12629.0 12653.1 12693.1 12777.5 4526.3 4611.7 4644.4 4656.8 4723.6 10736.0 10751.6 10875.2 10880.6 10891.2 5342.4 5388.2 5393.0 5399.5 5427.6 4382.1 4862.2 4925.9 5016.4 5022.3 4132.6 4195.3 4210.7 4242.5 4249.1 1326.6 1345.0 1351.6 1355.1 1359.8 957.7 1004.9 1029.6 1045.7 1046.0 6221.0 6289.2 6299.2 6355.2 6453.0 483.9 485.7 487.6 490.4 499.9 4457.5 4505.5 4512.4 4514.5 4535.1 11144.3 11497.1 11546.5 11551.9 11579.5 10355.8 11295.9 11393.5 11483.1 11503.0 8229.0 8621.1 8691.1 8702.6 8705.7 6355.2 6581.3 6600.8 6627.8 6681.2 10464.3 10689.7 10762.6 10801.6 10852.7 10759.4 10840.9 10906.9 10933.6 10946.5 7175.1 8014.9 8158.3 8236.4 8264.0 9116.6 9136.3 9136.5 9140.6 9214.8 8091.2 8284.7 8345.3 8452.8 8456.6 8271.9 8296.5 8313.4 8347.1 8389.0 7443.8 7575.1 7576.6 7611.6 7617.8 5527.5 5644.8 5652.7 5723.1 5793.9 5639.4 5702.6 5707.7 5717.5 5752.6 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | [#4] prototype.html Cycles:180 Average:4829.11 Median:5400.65 stddev:1405.16 (26.0%) stddev-sans-first:1368.21 05:04:44 INFO - PROCESS | 29666 | Values: 345.7 348.7 365.1 366.0 370.2 5555.2 5577.2 5594.4 5635.3 5638.5 5517.3 5538.6 5547.0 5569.2 5580.9 4218.7 4379.2 4388.8 4389.3 4407.2 4340.5 4341.6 4372.8 4414.1 4437.7 4343.3 4386.8 4433.6 4439.2 4441.4 4291.5 4367.9 4380.7 4381.8 4406.4 3824.9 3828.1 3865.8 3868.7 3874.7 5399.5 5417.6 5444.0 5444.3 5494.6 4924.7 4978.3 4985.1 4986.9 5043.0 5793.2 5824.2 5849.9 5856.5 5899.9 4253.6 4262.0 4264.6 4268.2 4277.6 5912.6 5994.8 6005.4 6100.3 6102.1 4196.7 4254.0 4265.7 4266.9 4275.7 4282.9 4308.3 4315.0 4336.4 4339.6 4868.2 4945.0 4947.4 4986.3 4999.1 5884.5 5889.8 5895.4 5916.2 5939.8 1486.4 1492.9 1509.5 1519.8 1520.0 950.4 978.8 990.7 999.6 999.9 5148.3 5174.7 5176.9 5196.9 5198.3 5372.5 5416.8 5425.5 5427.4 5432.1 4822.4 5046.9 5146.2 5170.7 5206.6 2869.4 2878.2 2885.2 2897.8 2900.5 5586.1 5615.2 5619.2 5635.4 5664.5 5082.8 5449.7 5458.3 5467.5 5551.9 5575.7 5623.9 5646.2 5648.4 5690.8 5133.4 5338.4 5367.5 5389.7 5401.8 5318.7 5331.9 5364.6 5396.2 5402.9 6159.7 6310.6 6355.9 6410.5 6466.9 4334.3 4344.3 4402.9 4411.3 4417.2 6091.6 6202.8 6202.9 6203.2 6240.7 5942.4 5952.8 5992.5 6000.8 6018.7 5881.7 5960.3 5994.9 5995.6 6020.5 5746.3 5913.5 5914.8 5921.3 5939.7 5959.8 5988.3 5991.9 6016.5 6037.5 5622.1 5884.4 5896.5 5896.9 5923.0 05:04:44 INFO - PROCESS | 29666 | 05:04:44 INFO - PROCESS | 29666 | [#5] yui.html Cycles:180 Average:20560.63 Median:5025.46 stddev:29011.49 (577.3%) stddev-sans-first:29054.72 05:04:44 INFO - PROCESS | 29666 | Values: 744.9 774.1 852.8 889.4 911.0 15968.6 17021.4 17516.5 17563.9 17593.9 15925.4 16193.4 16215.8 16227.8 16238.9 711.3 833.9 855.7 860.9 865.5 858.4 858.7 866.7 867.1 868.4 908.9 909.7 911.6 913.3 913.7 905.1 907.9 907.9 908.4 908.9 663.2 664.6 667.6 669.1 669.1 13184.3 13203.3 13214.5 13252.8 13282.1 15670.7 16177.1 16308.0 16518.3 16738.0 12558.4 12838.3 12965.5 12977.9 13120.4 4141.7 4227.6 4253.9 4263.9 4266.8 77906.6 78162.6 78236.6 81349.0 82690.6 12722.0 12776.9 12790.6 12818.6 12865.3 24156.5 24317.4 24444.0 24927.4 25204.4 8193.9 8345.5 8382.6 8966.2 9385.4 5020.3 5060.3 5090.1 5146.7 5228.1 3656.9 3796.4 3801.7 3806.6 3811.2 583.2 633.7 641.1 644.7 644.8 704.4 711.7 727.6 763.1 771.9 9976.0 10278.8 10399.0 10588.3 10622.9 696.3 701.0 707.5 757.8 767.4 4939.8 5010.1 5030.6 5054.9 5069.3 96167.5 114082.0 116265.0 118805.4 119274.4 61716.4 63100.4 77096.0 78033.2 97987.5 86997.0 88886.6 91521.0 92310.5 92546.1 9356.0 9451.1 9490.5 9505.6 9594.0 51140.7 52042.2 52929.7 53413.5 54180.5 69994.0 77323.6 78090.6 79899.6 81435.0 11759.4 11806.6 11835.3 11947.0 12454.0 13418.2 13528.7 13530.1 13565.2 13622.5 12651.7 12754.8 12773.4 12796.9 12898.4 12410.3 12447.2 12519.7 12809.0 13163.5 11938.3 12132.8 12181.9 12234.8 12253.2 10340.5 10639.3 10729.5 10786.2 10838.5 10649.4 10807.8 10822.4 10987.4 11080.8 05:04:44 INFO - PROCESS | 29666 | -------- Summary: end -------- 05:04:44 INFO - PROCESS | 29666 | 05:04:45 INFO - TEST-INFO | 29666: exit 0 05:04:45 INFO - TEST-OK | dromaeo_css | took 1109893ms 05:04:45 INFO - TEST-START | kraken 05:04:45 INFO - operating with platform_type : linux_ 05:04:45 INFO - Initialising browser for kraken test... 05:04:45 INFO - TEST-INFO | started process 29915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprUojgg/profile http://localhost:35507/getInfo.html) 05:04:49 INFO - PROCESS | 29915 | __metrics Screen width/height:1600/1200 05:04:49 INFO - PROCESS | 29915 | colorDepth:24 05:04:49 INFO - PROCESS | 29915 | Browser inner width/height: 1024/697 05:04:49 INFO - PROCESS | 29915 | __metrics 05:04:50 ERROR - PROCESS | 29915 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:04:51 INFO - TEST-INFO | 29915: exit 0 05:04:51 INFO - Browser initialized. 05:04:51 INFO - Running cycle 1/1 for kraken test... 05:04:51 INFO - TEST-INFO | started process 30044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprUojgg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:03 INFO - PROCESS | 30044 | RSS: Main: 156577792 05:05:03 INFO - PROCESS | 30044 | 05:05:05 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35507/tests/kraken/driver.html?testName=audio-beat-detection) 05:05:06 INFO - PROCESS | 30044 | RSS: Main: 161558528 05:05:06 INFO - PROCESS | 30044 | 05:05:09 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35507/tests/kraken/driver.html?testName=audio-dft) 05:05:09 INFO - PROCESS | 30044 | RSS: Main: 160587776 05:05:09 INFO - PROCESS | 30044 | 05:05:12 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35507/tests/kraken/driver.html?testName=audio-fft) 05:05:13 INFO - PROCESS | 30044 | RSS: Main: 161509376 05:05:13 INFO - PROCESS | 30044 | 05:05:15 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35507/tests/kraken/driver.html?testName=audio-oscillator) 05:05:15 INFO - PROCESS | 30044 | RSS: Main: 160792576 05:05:15 INFO - PROCESS | 30044 | 05:05:18 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35507/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:05:18 INFO - PROCESS | 30044 | RSS: Main: 160976896 05:05:18 INFO - PROCESS | 30044 | 05:05:21 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35507/tests/kraken/driver.html?testName=imaging-darkroom) 05:05:22 INFO - PROCESS | 30044 | RSS: Main: 160813056 05:05:22 INFO - PROCESS | 30044 | 05:05:26 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35507/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:26 INFO - PROCESS | 30044 | RSS: Main: 157560832 05:05:26 INFO - PROCESS | 30044 | 05:05:29 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35507/tests/kraken/driver.html?testName=json-parse-financial) 05:05:30 INFO - PROCESS | 30044 | RSS: Main: 159117312 05:05:30 INFO - PROCESS | 30044 | 05:05:31 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35507/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:32 INFO - PROCESS | 30044 | RSS: Main: 159444992 05:05:32 INFO - PROCESS | 30044 | 05:05:33 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:34 INFO - PROCESS | 30044 | RSS: Main: 159698944 05:05:34 INFO - PROCESS | 30044 | 05:05:36 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:37 INFO - PROCESS | 30044 | RSS: Main: 160100352 05:05:37 INFO - PROCESS | 30044 | 05:05:39 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:40 INFO - PROCESS | 30044 | RSS: Main: 160444416 05:05:40 INFO - PROCESS | 30044 | 05:05:43 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:43 INFO - PROCESS | 30044 | RSS: Main: 160100352 05:05:43 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | Cycle 1(1): loaded http://localhost:35507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35507/tests/kraken/driver.html?testName=ai-astar) 05:05:45 INFO - PROCESS | 30044 | RSS: Main: 160989184 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | __start_tp_report 05:05:45 INFO - PROCESS | 30044 | _x_x_mozilla_page_load 05:05:45 INFO - PROCESS | 30044 | _x_x_mozilla_page_load_details 05:05:45 INFO - PROCESS | 30044 | |i|pagename|runs| 05:05:45 INFO - PROCESS | 30044 | |0;ai-astar;112;105;110;111;112;112;111;110;111;113 05:05:45 INFO - PROCESS | 30044 | |1;audio-beat-detection;156;123;153;175;127;151;156;129;183;125 05:05:45 INFO - PROCESS | 30044 | |2;audio-dft;162;162;162;162;163;163;165;162;161;163 05:05:45 INFO - PROCESS | 30044 | |3;audio-fft;77;75;75;180;74;75;75;75;179;75 05:05:45 INFO - PROCESS | 30044 | |4;audio-oscillator;85;85;151;84;84;85;143;85;84;157 05:05:45 INFO - PROCESS | 30044 | |5;imaging-gaussian-blur;118;118;117;117;117;118;119;117;117;117 05:05:45 INFO - PROCESS | 30044 | |6;imaging-darkroom;147;147;151;148;148;148;147;147;148;148 05:05:45 INFO - PROCESS | 30044 | |7;imaging-desaturate;95;96;95;96;95;95;96;95;96;95 05:05:45 INFO - PROCESS | 30044 | |8;json-parse-financial;55;53;52;52;55;52;52;52;53;52 05:05:45 INFO - PROCESS | 30044 | |9;json-stringify-tinderbox;59;60;59;60;60;59;59;60;60;59 05:05:45 INFO - PROCESS | 30044 | |10;stanford-crypto-aes;79;77;86;79;83;79;78;77;104;76 05:05:45 INFO - PROCESS | 30044 | |11;stanford-crypto-ccm;123;117;128;141;133;125;130;137;133;133 05:05:45 INFO - PROCESS | 30044 | |12;stanford-crypto-pbkdf2;157;155;155;153;159;150;152;150;151;164 05:05:45 INFO - PROCESS | 30044 | |13;stanford-crypto-sha256-iterative;62;62;63;61;62;64;63;60;60;61 05:05:45 INFO - PROCESS | 30044 | __end_tp_report 05:05:45 INFO - PROCESS | 30044 | __start_cc_report 05:05:45 INFO - PROCESS | 30044 | _x_x_mozilla_cycle_collect,889 05:05:45 INFO - PROCESS | 30044 | __end_cc_report 05:05:45 INFO - PROCESS | 30044 | __startTimestamp1469448345682__endTimestamp 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | ------- Summary: start ------- 05:05:45 INFO - PROCESS | 30044 | Number of tests: 14 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.21 (2.0%) stddev-sans-first:2.30 05:05:45 INFO - PROCESS | 30044 | Values: 112.0 105.0 110.0 111.0 112.0 112.0 111.0 110.0 111.0 113.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:154.50 stddev:21.27 (13.8%) stddev-sans-first:22.35 05:05:45 INFO - PROCESS | 30044 | Values: 156.0 123.0 153.0 175.0 127.0 151.0 156.0 129.0 183.0 125.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:05:45 INFO - PROCESS | 30044 | Values: 162.0 162.0 162.0 162.0 163.0 163.0 165.0 162.0 161.0 163.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.00 stddev:44.02 (58.7%) stddev-sans-first:46.15 05:05:45 INFO - PROCESS | 30044 | Values: 77.0 75.0 75.0 180.0 74.0 75.0 75.0 75.0 179.0 75.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:84.50 stddev:31.94 (37.8%) stddev-sans-first:33.11 05:05:45 INFO - PROCESS | 30044 | Values: 85.0 85.0 151.0 84.0 84.0 85.0 143.0 85.0 84.0 157.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 05:05:45 INFO - PROCESS | 30044 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 119.0 117.0 117.0 117.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 05:05:45 INFO - PROCESS | 30044 | Values: 147.0 147.0 151.0 148.0 148.0 148.0 147.0 147.0 148.0 148.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:05:45 INFO - PROCESS | 30044 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.50 stddev:1.23 (2.3%) stddev-sans-first:1.01 05:05:45 INFO - PROCESS | 30044 | Values: 55.0 53.0 52.0 52.0 55.0 52.0 52.0 52.0 53.0 52.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 05:05:45 INFO - PROCESS | 30044 | Values: 59.0 60.0 59.0 60.0 60.0 59.0 59.0 60.0 60.0 59.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:79.00 stddev:8.36 (10.6%) stddev-sans-first:8.81 05:05:45 INFO - PROCESS | 30044 | Values: 79.0 77.0 86.0 79.0 83.0 79.0 78.0 77.0 104.0 76.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:133.00 stddev:7.02 (5.3%) stddev-sans-first:6.98 05:05:45 INFO - PROCESS | 30044 | Values: 123.0 117.0 128.0 141.0 133.0 125.0 130.0 137.0 133.0 133.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.00 stddev:4.45 (2.9%) stddev-sans-first:4.64 05:05:45 INFO - PROCESS | 30044 | Values: 157.0 155.0 155.0 153.0 159.0 150.0 152.0 150.0 151.0 164.0 05:05:45 INFO - PROCESS | 30044 | 05:05:45 INFO - PROCESS | 30044 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.32 (2.1%) stddev-sans-first:1.39 05:05:45 INFO - PROCESS | 30044 | Values: 62.0 62.0 63.0 61.0 62.0 64.0 63.0 60.0 60.0 61.0 05:05:45 INFO - PROCESS | 30044 | -------- Summary: end -------- 05:05:45 INFO - PROCESS | 30044 | 05:05:46 INFO - TEST-INFO | 30044: exit 0 05:05:46 INFO - TEST-OK | kraken | took 61247ms 05:05:46 INFO - SUITE-END | took 1171s 05:05:46 INFO - Completed test suite (00:19:31) 05:05:46 INFO - javascript benchmark 05:05:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7323.943314793045, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.2995870867117, 3394.0496660934914, 3406.437937740272, 3424.075499615104, 3429.639887811778, 5614.635048721831, 5621.690807005613, 5653.717314134287, 5661.547076233902, 5723.370429252779, 5725.997950358681, 5732.79935202268, 5757.856053598662, 5774.682392468412, 5775.913361299574, 5150.3047088643025, 5165.81919632813, 5229.0, 5263.34208223972, 5264.105102132647, 5145.073886700392, 5159.613029022819, 5268.104422248227, 5277.656952298107, 5278.261043453919, 5228.555572776299, 5231.5814734821315, 5243.764030618631, 5273.789048438058, 5279.2872962150195, 5243.9213411798855, 5248.160294352885, 5316.973415132899, 5322.7072511011875, 5330.653507522037, 5190.688558686491, 5232.529072383504, 5283.418823929364, 5293.682379057269, 5325.680459172462, 5427.968685949657, 5467.07059799831, 5502.339719233718, 5569.136783798518, 5616.691081990489, 6094.146819445281, 6125.724342404558, 6135.141080248769, 6137.171481849938, 6145.170401995762, 5994.520438364921, 6171.105189747506, 6184.165137706442, 6185.56701030928, 6193.597416167935, 5607.607467477278, 5616.831495055155, 5666.150077488369, 5686.147077938343, 5717.456841600041, 6166.414190651881, 6197.225346831646, 6207.099970504342, 6210.099535567318, 6250.843728906813, 5730.054541000772, 5871.119332100134, 5992.041273396236, 5997.190379298826, 6016.8796624068145, 6036.185115009417, 6123.08153776937, 6152.323244443108, 6155.538334624921, 6158.630482171084, 6043.637381757108, 6047.637141771508, 6101.908471372933, 6112.572119951649, 6117.318435754137, 5918.0, 5998.610090344201, 6033.849153771103, 6044.546659000593, 6130.111133885562, 4704.9529504704515, 4708.364370809965, 4709.105269998689, 4731.148393289241, 4731.361266229083, 4180.226658068206, 4188.979055104705, 4201.138766552849, 4202.642775364067, 4231.830726770956, 5811.709414529257, 5868.178455016301, 5897.587168898136, 5913.053911374245, 5917.023691091008, 5931.169636250928, 6030.095485677183, 6121.269493298861, 6127.953177891157, 6217.4715149212825, 5819.709014549256, 5879.118132280107, 5882.705864706833, 5894.204282421904, 5896.380880007623, 5019.874503137451, 5140.588752899759, 5168.819091331786, 5205.401378841406, 5244.9737751310995, 6336.6831658416895, 6374.171357723466, 6399.2640846303275, 6401.871962560723, 6419.422251997343, 5864.530837532901, 6178.505719542426, 6193.040078787795, 6196.411340922605, 6207.596506227081, 6211.0372892201785, 6224.253089629274, 6305.148804911279, 6391.073294372197, 6395.744170233139, 5998.550108741949, 6007.279126504847, 6015.909761353496, 6019.6756713522955, 6019.729112189874, 5946.583739138218, 6059.909101363572, 6111.252045622946, 6123.343628574382, 6138.907916381168, 5929.110633405024, 6042.879142417215, 6060.848478787889, 6068.939310606837, 6112.358202388863, 6003.8198854034445, 6009.759609615567, 6044.9395506044375, 6053.4551890330085, 6063.6664983426335, 5670.829875103754, 5774.1916131740745, 5815.069588865761, 5906.202662640489, 5923.851903702442, 6006.699665016819, 6033.728482218398, 6048.909266361096, 6061.969690151521, 6079.452849243589, 5884.47039766423, 5889.0, 5893.292804863444, 5898.469137777621, 5919.526437885045], "value": 5641.870317333489, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.5753972219447, 650.9479241660667, 664.8470851704108, 668.3049628386478, 669.2069897171849, 44671.0, 46538.3019254711, 46542.767286163566, 50446.0, 50480.747596261965, 44822.55177448224, 45336.773316133455, 45362.77318613402, 45413.31880021794, 45483.0, 8536.48781073136, 8837.38138330317, 8849.115088491131, 8851.468911865277, 8859.822803543926, 8785.209331160195, 8851.468911865277, 8854.0, 8855.690050848221, 8868.467891926504, 8809.0, 8815.867761983576, 8855.867161992543, 8864.113588641148, 8899.154580314893, 8828.646854125827, 8837.646494140226, 8881.0, 8889.466632002068, 8902.955485222597, 8768.605412756377, 8852.0, 8874.911250887537, 8885.378023538355, 8897.243734282594, 42003.57996420058, 42415.57584424147, 42449.787751061354, 42561.14877702429, 42599.0, 3651.4887915691825, 3819.52255968004, 3841.19334939663, 3878.8836334909997, 3942.4874766280486, 34171.82914085439, 34385.82807085974, 34403.655963440295, 34452.0, 35674.64325356765, 4665.650076244296, 4834.685745426571, 4844.0, 4872.196087645534, 4913.926291105637, 386080.0, 387550.0, 387843.0, 387900.0604996985, 388642.0, 37466.06334841596, 38454.0, 68075.3192468069, 68610.0, 68769.65615171893, 39801.20397592032, 39805.80097099496, 39853.40219896704, 39956.40065399021, 39981.40027899584, 15651.139187344805, 15677.686446271238, 15687.98028128168, 15714.057156570643, 15778.526644200692, 14664.120152790867, 14790.408383664748, 14833.184174870486, 14873.0, 14876.553703388916, 8995.775105622412, 9093.545322733837, 9106.134917182857, 9149.176574108362, 9162.267018638493, 3424.417848965682, 3454.0674018014997, 3484.738644601665, 3493.0, 3510.613832478425, 1103.2938919091628, 1129.6159305836056, 1141.2296699727651, 1162.3723189477757, 1225.2770865189582, 33689.66310336865, 34628.65371346254, 34802.651973480446, 34864.30271394558, 35305.0, 1157.7279339355246, 1186.1044911092242, 1204.6989251608243, 1206.595790410205, 1292.75437666843, 17634.206460709298, 18134.818651813577, 18270.54323641893, 18285.908570457064, 18355.0, 632637.0, 644708.0, 649803.0, 660762.0, 664163.0, 58126.709366452895, 58238.0, 58510.414895850496, 58546.0, 58708.41291587029, 1444.8410674825761, 1447.6887469194173, 1448.0298200205887, 1451.992740036293, 1489.3393865839512, 30654.693453065185, 32733.836330818194, 32918.50622240716, 33195.66804331926, 33326.16684582808, 51385.0, 52044.21933671074, 52162.47837521728, 52174.0, 52400.47599523956, 302320.0, 302762.0, 380772.0, 381304.0, 381527.0, 29286.0, 30023.249418764706, 30150.698493015665, 30179.547306789977, 30229.697703022688, 48141.0, 48992.81434741939, 49037.0, 49068.263976041104, 49714.50285497099, 39539.80230098831, 39962.20075598414, 40918.83157240522, 41745.0, 41861.1627767449, 39956.600433995285, 40141.0, 40480.3927941087, 41250.1749965005, 42122.7893860541, 41939.580604193565, 42666.0, 42744.0, 42905.78547107244, 42932.35601466043, 35456.82271588626, 35818.64181358153, 36386.0, 36416.27167456583, 36581.81709091544, 28108.578371324038, 28531.10162390805, 28929.710702892702, 29187.416251675273, 29301.560476593295], "value": 19719.008850022874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.75123796389283, 396.69058134654944, 404.6883899397464, 408.8303354108044, 419.1282133163021, 14869.55391338259, 18140.546486337847, 19771.703424448628, 19799.703004454946, 20578.69131963018, 18177.272909083655, 18460.81539184611, 18741.812581874176, 20180.59638807223, 20208.69686954697, 5573.164025396182, 5677.574181936361, 5869.50109240715, 5871.970640146793, 5878.911816322759, 5336.439673834249, 5616.466435688603, 5802.0, 5807.854803629922, 5821.27234095738, 5638.351589567212, 5643.774249030034, 5651.32184137902, 5660.377358490563, 5671.149327600851, 5482.5613950884035, 5788.189653448541, 5812.244408226925, 5871.706414679292, 5882.911756323659, 5475.945240547583, 5634.183043458716, 5648.745806438679, 5660.150977353389, 5669.603127781057, 13112.934435327857, 13127.474901003949, 16872.493825185265, 23741.88129059361, 23900.28299151028, 2308.4921317310163, 2335.988320058406, 2396.364963284731, 2673.358393985449, 2961.1098929575105, 10214.795704085951, 10620.681379558626, 10642.946785266024, 10829.404382758945, 10875.45622718861, 1968.22255209193, 2041.7039529268172, 2113.429374069008, 2149.720536330283, 2168.6746987951774, 63314.68342658303, 81247.5937620314, 81341.59329203375, 81668.59165704134, 83432.0, 11001.17491188164, 11230.550777968952, 11460.312381256985, 11674.94162529182, 11750.059995200363, 16345.754813677804, 16355.509334719978, 16411.91794041022, 16492.752608710878, 16526.752098718527, 8586.441881277697, 8819.955900220459, 8823.426477278956, 8894.777630559287, 8979.0, 8446.155384461505, 8548.187922147386, 8574.442661227, 8586.570671466401, 8716.259117974916, 4853.126437241331, 4901.411830580353, 4912.189488734391, 4984.451710311862, 5019.824306149268, 2021.9393418197478, 2032.2582257475915, 2036.5417780999157, 2088.2691058129535, 2138.134055707441, 487.1353347807599, 500.5395036566295, 925.2967744514218, 1017.8269694152012, 1159.243745725227, 12044.988752811798, 12410.5656302029, 12461.1900226485, 12831.0, 12856.228626282265, 492.30339070215246, 513.117438006628, 515.6467819543625, 516.49641599441, 517.751479289943, 6715.3620406061345, 6893.0694356261265, 6911.516193866481, 6927.896081558781, 6948.826279342956, 545608.0, 549803.0, 553157.0, 553977.0, 556146.0, 99775.50112249538, 100451.0, 100702.0, 101916.49041754892, 103135.0, 514.4135685318739, 520.3417676639054, 525.3669328459198, 526.0504788856075, 526.7866514061811, 11740.41297935117, 11792.70518237051, 11926.880731192578, 11953.701157471132, 11978.76042479163, 38673.613263867, 40438.59561404349, 42252.57747422486, 43278.0, 44999.0, 59657.40342596518, 59837.0, 60403.395966039774, 61481.0, 62362.68818655878, 7737.613119343898, 8082.595870206349, 8092.595370231347, 8583.18459746323, 8941.418807777474, 9994.800103998024, 13335.466581337027, 13369.866301337252, 13455.0, 13565.660858478617, 11478.598249061577, 11705.180637355303, 11834.171607987359, 11882.405879706153, 11952.804719528325, 11205.71985700364, 11323.716907077389, 11457.0, 11460.770784584094, 11541.422928853692, 6556.213254409501, 8923.0, 11687.824682629938, 11808.881911180779, 11887.821682674594, 7322.231165727522, 7801.45389822707, 8169.877451838108, 8211.71259005932, 8257.463264887763, 11309.547618095514, 11608.477618507019, 11639.127065470293, 11676.766464670489, 11682.415879206175], "value": 8592.759599949988, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.4626753769949, 1559.539935718963, 1743.8343357381045, 1810.1039985207324, 1844.880082794619, 7715.768526944201, 8618.525981071038, 8746.518941458226, 9150.49672268025, 9216.262698984083, 8612.870806937884, 8815.735527934172, 8887.555622218895, 8950.82098358034, 8978.416402933804, 2222.3888430681573, 2272.4091736148557, 2276.0, 2276.430892276931, 2278.6354183330673, 2354.82338824588, 2366.349253955159, 2377.1561095811, 2378.4410663494064, 2386.988065059681, 2386.713594368678, 2395.940101497468, 2403.3871362802547, 2405.1822380390663, 2420.98318706143, 2281.9657705134437, 2288.725352957639, 2301.3326135420707, 2305.8847057647135, 2311.7688231176917, 2279.8290128240446, 2292.885355732207, 2304.481491664379, 2311.861288322706, 2314.8032417244553, 8955.552222388855, 8957.731268061969, 8961.731148065503, 8972.147645973622, 9026.54867256641, 5271.604629652753, 5365.865853353658, 5403.324584426947, 5403.7027963462, 5407.675539467645, 3431.365197438482, 3528.4001719707453, 3560.181158333598, 3565.2691198304287, 3637.7089832813313, 1232.4084439469104, 1259.0, 1272.2112290380023, 1288.1948782011243, 1288.6778305423645, 12555.93722031384, 12629.0, 12653.114282000264, 12693.11148219625, 12777.488900443972, 4526.343680166357, 4611.654125940501, 4644.419447569054, 4656.8125128092115, 4723.574878260973, 10736.0, 10751.569937202581, 10875.238733288594, 10880.564777408816, 10891.237613366988, 5342.358916929993, 5388.164834450667, 5392.973035134799, 5399.460053994648, 5427.6472029317965, 4382.101669157879, 4862.222044472867, 4925.926111108336, 5016.44819069902, 5022.271770593316, 4132.648724858421, 4195.328747400401, 4210.6841986850495, 4242.490901091889, 4249.128928569636, 1326.635175326793, 1345.031577264368, 1351.6215459671307, 1355.1259437662652, 1359.823222981026, 957.707899090784, 1004.9196064314838, 1029.6499190275342, 1045.749020235138, 1045.9790804183874, 6221.0, 6289.182406287154, 6299.244090709144, 6355.237371515448, 6452.967525195946, 483.941926968766, 485.7255650557494, 487.6440198654931, 490.37232342601527, 499.8700337912169, 4457.531959144308, 4505.504394516601, 4512.368268442421, 4514.503404625489, 4535.115652447741, 11144.275622084539, 11497.137714671266, 11546.538138474367, 11551.884481155248, 11579.536818527165, 10355.844662330072, 11295.943520282346, 11393.487293071832, 11483.081353491702, 11503.0, 8228.958855205805, 8621.137886211329, 8691.087435819149, 8702.608382622671, 8705.695300664447, 6355.237371515448, 6581.3418658133805, 6600.8349791255605, 6627.768028118992, 6681.198256209286, 10464.267501274837, 10689.732756681145, 10762.569497220024, 10801.621943231949, 10852.728681782703, 10759.408232546972, 10840.891591084304, 10906.890931090587, 10933.56265749361, 10946.507407166855, 7175.067241258603, 8014.919850801417, 8158.3065439438315, 8236.423450358418, 8263.95868020656, 9116.589753461243, 9136.314776391664, 9136.543172841464, 9140.63437462494, 9214.769630759016, 8091.1504292048485, 8284.71003514874, 8345.332373410234, 8452.788680282796, 8456.577171141542, 8271.875921861298, 8296.502209867427, 8313.41806073569, 8347.12355202695, 8389.0, 7443.81390465221, 7575.053118360205, 7576.621168941641, 7611.619419028915, 7617.771466856003, 5527.50757295536, 5644.8024319148635, 5652.689102099424, 5723.084306510938, 5793.91309130355, 5639.351474580476, 5702.600817942704, 5707.714614269353, 5717.485426311652, 5752.597318187687], "value": 4771.62283883024, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6612519730664, 348.65483171660054, 365.1419164962339, 365.9853605855766, 370.2280744647408, 5555.222268882349, 5577.219189313494, 5594.440555944404, 5635.295588051494, 5638.520725738312, 5517.317218248432, 5538.556915446765, 5547.0, 5569.192467092269, 5580.888382232363, 4218.704690671654, 4379.167958087969, 4388.780560971954, 4389.341598760179, 4407.162639098577, 4340.52254252032, 4341.6092551670345, 4372.825086996516, 4414.09511050234, 4437.733735975852, 4343.305071188611, 4386.824527018932, 4433.578810013044, 4439.178751930887, 4441.422615060038, 4291.549387314334, 4367.889569204039, 4380.693351465398, 4381.816909434467, 4406.449193850769, 3824.8852534424013, 3828.1386687995255, 3865.8067096645336, 3868.7233213039913, 3874.651281384689, 5399.514043736082, 5417.6207665463435, 5443.972780136113, 5444.346678398578, 5494.560435165177, 4924.729139897304, 4978.327925730016, 4985.052839960432, 4986.850394488171, 5042.974785126051, 5793.188953546507, 5824.213731146283, 5849.853753656193, 5856.472917437451, 5899.941000589982, 4253.553376895412, 4262.0, 4264.616184543375, 4268.189044081614, 4277.550857160016, 5912.6156799808305, 5994.820155395345, 6005.399460054047, 6100.298465676459, 6102.145699602059, 4196.706230563892, 4253.957460425418, 4265.722728022669, 4266.914661706811, 4275.722078064916, 4282.8715138545895, 4308.332208507623, 4314.956850431456, 4336.392904993303, 4339.609435150788, 4868.196747536616, 4945.0, 4947.381577302837, 4986.301917731521, 4999.0501804657, 5884.499817515559, 5889.764409423661, 5895.41045895407, 5916.171735956969, 5939.822195125587, 1486.3757221966584, 1492.8581784730434, 1509.5018643847504, 1519.840416756247, 1520.0423733048108, 950.4202436513721, 978.7504186432415, 990.6829814459448, 999.6151481679606, 999.8550210219478, 5148.279240906276, 5174.663646862942, 5176.945602094707, 5196.870078248074, 5198.32421785173, 5372.52255629705, 5416.756245968941, 5425.484578964992, 5427.4301198373605, 5432.13085906261, 4822.432709369469, 5046.870940017213, 5146.224552529371, 5170.741462926839, 5206.609504287194, 2869.397426540408, 2878.2372671242138, 2885.2354126156583, 2897.8261304321386, 2900.506913824655, 5586.13414920688, 5615.241942337732, 5619.213310136584, 5635.436456354331, 5664.461876121762, 5082.771275292621, 5449.700266485302, 5458.317710286215, 5467.4532546745, 5551.916721249185, 5575.749091290902, 5623.8875222496135, 5646.20953066571, 5648.406917273709, 5690.800821971294, 5133.383993920754, 5338.412774594869, 5367.463253674601, 5389.7035663038905, 5401.783928642811, 5318.7074710891275, 5331.946680533145, 5364.570834333322, 5396.21754845553, 5402.8649283766645, 6159.722812473539, 6310.580119473082, 6355.90466142999, 6410.5192110592825, 6466.902996454963, 4334.2631752602765, 4344.283193273074, 4402.933955990727, 4411.2721400968485, 4417.160739459492, 6091.634501929899, 6202.782902598387, 6202.937970620236, 6203.193584833943, 6240.656763878031, 5942.405759424023, 5952.76188952437, 5992.490638295793, 6000.759969601167, 6018.668973206516, 5881.705914704333, 5960.314563825043, 5994.910076348771, 5995.5803093783015, 6020.524971382039, 5746.310442746897, 5913.526917846476, 5914.763409463573, 5921.3190483094995, 5939.703014849154, 5959.761609535743, 5988.335190840035, 5991.880162396815, 6016.518678505797, 6037.516998640011, 5622.064554811566, 5884.352721200579, 5896.528277737685, 5896.941030589811, 5922.970385148046], "value": 4386.425740993491, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9031625888633, 774.0865778381511, 852.7995920958575, 889.4040992535001, 910.9544522773859, 15968.600784980381, 17021.40425085122, 17516.474505764814, 17563.91218043908, 17593.91203043983, 15925.44260950867, 16193.35226590938, 16215.83784162158, 16227.756583651255, 16238.918805405987, 711.2567367101378, 833.9291160251356, 855.6620135046653, 860.8794768732382, 865.5369377383101, 858.3862538285125, 858.7166235142388, 866.7096522664915, 867.0765634599163, 868.4008034456205, 908.900020997693, 909.749818799832, 911.567005672307, 913.2693844924067, 913.7350168451142, 905.0768216419282, 907.8638204269347, 907.8955920069144, 908.4322298563364, 908.9181973622373, 663.2008429842028, 664.5580688841962, 667.5727534378002, 669.0599707411046, 669.1100835888257, 13184.274864882427, 13203.339833008311, 13214.537491187859, 13252.801207981887, 13282.070255082148, 15670.686586268212, 16177.110258935754, 16308.0, 16518.339266429328, 16738.0, 12558.372081395984, 12838.293893835835, 12965.481380744759, 12977.935110324388, 13120.409581568852, 4141.672111025317, 4227.556106608823, 4253.851115210953, 4263.872083837458, 4266.8293268269545, 77906.61046694787, 78162.60918695427, 78236.60881695613, 81349.0, 82690.58654706748, 12722.0, 12776.936115319364, 12790.552330668383, 12818.61544153677, 12865.2924089176, 24156.516869662508, 24317.392065198157, 24444.0, 24927.376815579755, 25204.369890752878, 8193.877091843628, 8345.499270043816, 8382.622781974826, 8966.237869781142, 9385.38994965325, 5020.2720605511995, 5060.291559181717, 5090.10923088458, 5146.716930568779, 5228.137357336073, 3656.8720094796554, 3796.3925771876366, 3801.7338786284695, 3806.5812760596314, 3811.1805961718364, 583.2388732703778, 633.7274971762187, 641.0864518061743, 644.7195469970578, 644.8097811145723, 704.3801454719916, 711.6797441151502, 727.6361819090455, 763.0881097088925, 771.9073711154585, 9976.0, 10278.794424111476, 10399.0, 10588.258821882548, 10622.893771062345, 696.314130581377, 700.9905735740517, 707.4729326651677, 757.837065031021, 767.4321002458253, 4939.777710003059, 5010.098182327143, 5030.647854650139, 5054.898902021939, 5069.290299358093, 96167.51916240514, 114082.0, 116265.0, 118805.40597296959, 119274.4036279813, 61716.38283617106, 63100.36899631037, 77096.0, 78033.21966780373, 97987.51006244923, 86997.0, 88886.55556722175, 91521.0, 92310.53844730734, 92546.07453925509, 9355.953220233856, 9451.149396554343, 9490.478023708762, 9505.619775208914, 9593.952030240083, 51140.74429627828, 52042.21936670877, 52929.735351323, 53413.465865342405, 54180.458195417545, 69994.0, 77323.61338193498, 78090.6095469519, 79899.60050199712, 81435.0, 11759.353235572125, 11806.645800625995, 11835.28988260707, 11947.0, 12454.029421170639, 13418.194908305533, 13528.661783455098, 13530.120542164728, 13565.186088834702, 13622.523211687543, 12651.746965060831, 12754.808677870025, 12773.445310938036, 12796.936015320236, 12898.41957111951, 12410.255384676948, 12447.190932589352, 12519.687007824878, 12809.0, 13163.53927612529, 11938.28370297785, 12132.75734485323, 12181.939090304491, 12234.816477752664, 12253.203541769757, 10340.53467593945, 10639.308444951053, 10729.517171727135, 10786.191035672513, 10838.512266948164, 10649.361038337414, 10807.783844323227, 10822.40476773785, 10987.39569323695, 11080.778384432428], "value": 7712.79937471507, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 110.0, 111.0, 112.0, 112.0, 111.0, 110.0, 111.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 153.0, 175.0, 127.0, 151.0, 156.0, 129.0, 183.0, 125.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 165.0, 162.0, 161.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 180.0, 74.0, 75.0, 75.0, 75.0, 179.0, 75.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 151.0, 84.0, 84.0, 85.0, 143.0, 85.0, 84.0, 157.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 52.0, 55.0, 52.0, 52.0, 52.0, 53.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 86.0, 79.0, 83.0, 79.0, 78.0, 77.0, 104.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 117.0, 128.0, 141.0, 133.0, 125.0, 130.0, 137.0, 133.0, 133.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 155.0, 153.0, 159.0, 150.0, 152.0, 150.0, 151.0, 164.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 62.0, 64.0, 63.0, 60.0, 60.0, 61.0], "value": 61.8, "unit": "score"}]}]} 05:05:46 INFO - Return code: 0 05:05:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:46 ERROR - # TBPL SUCCESS # 05:05:46 INFO - Running post-action listener: _resource_record_post_action 05:05:46 INFO - ##### 05:05:46 INFO - ##### Finished run-tests step (success) 05:05:46 INFO - ##### 05:05:46 INFO - Running post-run listener: _resource_record_post_run 05:05:47 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 286720; Write bytes: 254361600; Read time: 28; Write time: 149484 05:05:47 INFO - TinderboxPrint: CPU usage
13.4% 05:05:47 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 28 05:05:47 INFO - TinderboxPrint: I/O write bytes / time
254,361,600 / 149,484 05:05:47 INFO - TinderboxPrint: CPU idle
8,208.6 (86.6%) 05:05:47 INFO - TinderboxPrint: CPU user
1,216.6 (12.8%) 05:05:47 INFO - TinderboxPrint: Swap in / out
0 / 0 05:05:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6979584; Read time: 0; Write time: 1860 05:05:47 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247382016; Read time: 12; Write time: 147624 05:05:47 INFO - Running post-run listener: _upload_blobber_files 05:05:47 INFO - Blob upload gear active. 05:05:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:47 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:05:47 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:05:47 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:05:48 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:57 INFO - (blobuploader) - INFO - Done attempting. 05:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:58 INFO - (blobuploader) - INFO - Done attempting. 05:05:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:05:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:58 INFO - (blobuploader) - INFO - Done attempting. 05:05:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:58 INFO - Return code: 0 05:05:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6d09ba63c4489a66550dc68a9bd00febf4b80e9d465fab765364ec579dba08a8e2c5275f1d4780546b8c36f1def7ed335e85f9c933c57506b7b6e84594a8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/617533fd32ad5a774d52b1e3be20ef5fc4ce4a87961b555ca5b4187900c3bbfbeb0f69e365c4fa6d59c37ce269778ef9e253dfc6fd8c35a9311aa3ddbc03f92d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b546ec764425b50cc010e63112ed93f4e90ee04e44a6213697b7edb5f32fbc48c316165a75e62238f1ffd1e4ec6ed3dc5eb2b9a8a3f49e6e81198338ee133fdd"} 05:05:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:58 INFO - Contents: 05:05:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c6d09ba63c4489a66550dc68a9bd00febf4b80e9d465fab765364ec579dba08a8e2c5275f1d4780546b8c36f1def7ed335e85f9c933c57506b7b6e84594a8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/617533fd32ad5a774d52b1e3be20ef5fc4ce4a87961b555ca5b4187900c3bbfbeb0f69e365c4fa6d59c37ce269778ef9e253dfc6fd8c35a9311aa3ddbc03f92d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b546ec764425b50cc010e63112ed93f4e90ee04e44a6213697b7edb5f32fbc48c316165a75e62238f1ffd1e4ec6ed3dc5eb2b9a8a3f49e6e81198338ee133fdd"} 05:05:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:58 INFO - Copying logs to upload dir... 05:05:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.720599 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-07-25 05:05:57.421343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:05:57.425038) ========= 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=232498196343f89f466a4a9a000001c8-1469446835.232348-903693951 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/c6d09ba63c4489a66550dc68a9bd00febf4b80e9d465fab765364ec579dba08a8e2c5275f1d4780546b8c36f1def7ed335e85f9c933c57506b7b6e84594a8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/617533fd32ad5a774d52b1e3be20ef5fc4ce4a87961b555ca5b4187900c3bbfbeb0f69e365c4fa6d59c37ce269778ef9e253dfc6fd8c35a9311aa3ddbc03f92d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b546ec764425b50cc010e63112ed93f4e90ee04e44a6213697b7edb5f32fbc48c316165a75e62238f1ffd1e4ec6ed3dc5eb2b9a8a3f49e6e81198338ee133fdd"} build_url:https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/FBJIZmzeRzWE48WjAir0jg/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/c6d09ba63c4489a66550dc68a9bd00febf4b80e9d465fab765364ec579dba08a8e2c5275f1d4780546b8c36f1def7ed335e85f9c933c57506b7b6e84594a8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/617533fd32ad5a774d52b1e3be20ef5fc4ce4a87961b555ca5b4187900c3bbfbeb0f69e365c4fa6d59c37ce269778ef9e253dfc6fd8c35a9311aa3ddbc03f92d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b546ec764425b50cc010e63112ed93f4e90ee04e44a6213697b7edb5f32fbc48c316165a75e62238f1ffd1e4ec6ed3dc5eb2b9a8a3f49e6e81198338ee133fdd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:05:57.450267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:05:57.450593) ========= 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=232498196343f89f466a4a9a000001c8-1469446835.232348-903693951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:05:57.536114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:05:57.536447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:05:57.536726) ========= ========= Total master_lag: 0.17 =========