builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1465291597.22 results: success (0) buildid: 20160606202128 builduid: 7ec3cba5ae654a229f94a8ace0e91e74 revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.219065) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.219675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.220053) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.235070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.235435) ========= 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=cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:26:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.0M=0s 2016-06-07 02:26:37 (32.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.370218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.370598) ========= 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=cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021155 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.423039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:37.423765) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e70892847544db94d801f80543fe8a7f6d836f90 --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 e70892847544db94d801f80543fe8a7f6d836f90 --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=cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:26:37,944 truncating revision to first 12 chars 2016-06-07 02:26:37,944 Setting DEBUG logging. 2016-06-07 02:26:37,944 attempt 1/10 2016-06-07 02:26:37,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e70892847544?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 02:26:38,308 unpacking tar archive at: mozilla-aurora-e70892847544/testing/mozharness/ program finished with exit code 0 elapsedTime=0.687118 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.191608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.191951) ========= script_repo_revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.192385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.192706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.203045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2016-06-07 02:26:38.203356) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:26:38 INFO - MultiFileLogger online at 20160607 02:26:38 in /builds/slave/test 02:26:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:26:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:26:38 INFO - {'append_to_log': False, 02:26:38 INFO - 'base_work_dir': '/builds/slave/test', 02:26:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:26:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:26:38 INFO - 'branch': 'Mozilla-Aurora', 02:26:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:26:38 INFO - 'config_files': ('talos/linux_config.py',), 02:26:38 INFO - 'default_actions': ('clobber', 02:26:38 INFO - 'read-buildbot-config', 02:26:38 INFO - 'download-and-extract', 02:26:38 INFO - 'populate-webroot', 02:26:38 INFO - 'create-virtualenv', 02:26:38 INFO - 'install', 02:26:38 INFO - 'run-tests'), 02:26:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:26:38 INFO - 'download_minidump_stackwalk': True, 02:26:38 INFO - 'download_symbols': 'ondemand', 02:26:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:26:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:26:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:26:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:26:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:26:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:26:38 INFO - 'installer_path': 'installer.exe', 02:26:38 INFO - 'log_level': 'info', 02:26:38 INFO - 'log_name': 'talos', 02:26:38 INFO - 'log_to_console': True, 02:26:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:26:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:26:38 INFO - 'opt_config_files': (), 02:26:38 INFO - 'pip_index': False, 02:26:38 INFO - 'sps_profile': False, 02:26:38 INFO - 'sps_profile_interval': 0, 02:26:38 INFO - 'suite': 'dromaeojs', 02:26:38 INFO - 'system_bits': '32', 02:26:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:26:38 INFO - 'title': 'talos-linux64-ix-054', 02:26:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:26:38 INFO - 'use_talos_json': True, 02:26:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:26:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:26:38 INFO - 'work_dir': 'build'} 02:26:38 INFO - ##### 02:26:38 INFO - ##### Running clobber step. 02:26:38 INFO - ##### 02:26:38 INFO - Running pre-action listener: _resource_record_pre_action 02:26:38 INFO - Running main action method: clobber 02:26:38 INFO - rmtree: /builds/slave/test/build 02:26:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:26:39 INFO - Running post-action listener: _resource_record_post_action 02:26:39 INFO - ##### 02:26:39 INFO - ##### Finished clobber step (success) 02:26:39 INFO - ##### 02:26:39 INFO - ##### 02:26:39 INFO - ##### Running read-buildbot-config step. 02:26:39 INFO - ##### 02:26:39 INFO - Running pre-action listener: _resource_record_pre_action 02:26:39 INFO - Running main action method: read_buildbot_config 02:26:39 INFO - Using buildbot properties: 02:26:39 INFO - { 02:26:39 INFO - "project": "", 02:26:39 INFO - "product": "firefox", 02:26:39 INFO - "script_repo_revision": "production", 02:26:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:26:39 INFO - "repository": "", 02:26:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:26:39 INFO - "buildid": "20160606202128", 02:26:39 INFO - "pgo_build": "True", 02:26:39 INFO - "basedir": "/builds/slave/test", 02:26:39 INFO - "buildnumber": 370, 02:26:39 INFO - "slavename": "talos-linux64-ix-054", 02:26:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:26:39 INFO - "platform": "ubuntu64_hw", 02:26:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:26:39 INFO - "branch": "mozilla-aurora", 02:26:39 INFO - "repo_path": "releases/mozilla-aurora", 02:26:39 INFO - "revision": "e70892847544db94d801f80543fe8a7f6d836f90", 02:26:39 INFO - "stage_platform": "linux64-pgo", 02:26:39 INFO - "builduid": "7ec3cba5ae654a229f94a8ace0e91e74", 02:26:39 INFO - "slavebuilddir": "test" 02:26:39 INFO - } 02:26:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:26:39 INFO - Running post-action listener: _resource_record_post_action 02:26:39 INFO - ##### 02:26:39 INFO - ##### Finished read-buildbot-config step (success) 02:26:39 INFO - ##### 02:26:39 INFO - ##### 02:26:39 INFO - ##### Running download-and-extract step. 02:26:39 INFO - ##### 02:26:39 INFO - Running pre-action listener: _resource_record_pre_action 02:26:39 INFO - Running main action method: download_and_extract 02:26:39 INFO - mkdir: /builds/slave/test/build/tests 02:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:39 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:40 INFO - Downloaded 1361 bytes. 02:26:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:26:40 INFO - Using the following test package requirements: 02:26:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:26:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:26:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:26:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'jsshell-linux-x86_64.zip'], 02:26:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:26:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:26:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:26:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:26:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:26:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:26:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:40 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:41 INFO - Downloaded 24473779 bytes. 02:26:41 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'] 02:26:41 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 02:26:42 INFO - Return code: 0 02:26:42 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 02:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:42 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:44 INFO - Downloaded 24473779 bytes. 02:26:44 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'] 02:26:44 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 02:26:45 INFO - Return code: 0 02:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:45 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:46 INFO - Downloaded 10833369 bytes. 02:26:46 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'] 02:26:46 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 02:26:47 INFO - Return code: 0 02:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:47 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/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 02:26:48 INFO - Downloaded 63553597 bytes. 02:26:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:26:48 INFO - mkdir: /builds/slave/test/properties 02:26:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:48 INFO - Contents: 02:26:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:26:49 INFO - Running post-action listener: _resource_record_post_action 02:26:49 INFO - Running post-action listener: set_extra_try_arguments 02:26:49 INFO - ##### 02:26:49 INFO - ##### Finished download-and-extract step (success) 02:26:49 INFO - ##### 02:26:49 INFO - ##### 02:26:49 INFO - ##### Running populate-webroot step. 02:26:49 INFO - ##### 02:26:49 INFO - Running pre-action listener: _resource_record_pre_action 02:26:49 INFO - Running main action method: populate_webroot 02:26:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:49 INFO - '--tppagecycles', 02:26:49 INFO - '7'], 02:26:49 INFO - 'tests': ['tsvgm']}}, 02:26:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['damp', 'tps']}, 02:26:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'tests': ['damp', 'tps']}, 02:26:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['dromaeo_dom']}, 02:26:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['a11yr', 02:26:49 INFO - 'ts_paint', 02:26:49 INFO - 'tpaint', 02:26:49 INFO - 'sessionrestore', 02:26:49 INFO - 'sessionrestore_no_auto_restore', 02:26:49 INFO - 'tabpaint']}, 02:26:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:49 INFO - 'ts_paint', 02:26:49 INFO - 'tpaint', 02:26:49 INFO - 'sessionrestore', 02:26:49 INFO - 'sessionrestore_no_auto_restore', 02:26:49 INFO - 'tabpaint']}, 02:26:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:49 INFO - 'ts_paint', 02:26:49 INFO - 'tpaint', 02:26:49 INFO - 'sessionrestore', 02:26:49 INFO - 'sessionrestore_no_auto_restore', 02:26:49 INFO - 'tabpaint']}, 02:26:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:49 INFO - 'ts_paint', 02:26:49 INFO - 'tpaint', 02:26:49 INFO - 'sessionrestore', 02:26:49 INFO - 'sessionrestore_no_auto_restore', 02:26:49 INFO - 'tabpaint']}, 02:26:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['a11yr', 02:26:49 INFO - 'ts_paint', 02:26:49 INFO - 'tpaint', 02:26:49 INFO - 'sessionrestore', 02:26:49 INFO - 'sessionrestore_no_auto_restore', 02:26:49 INFO - 'tabpaint']}, 02:26:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['a11yr', 02:26:49 INFO - 'ts_paint', 02:26:49 INFO - 'tpaint', 02:26:49 INFO - 'sessionrestore', 02:26:49 INFO - 'sessionrestore_no_auto_restore', 02:26:49 INFO - 'tabpaint']}, 02:26:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['tsvgx', 02:26:49 INFO - 'tsvgr_opacity', 02:26:49 INFO - 'tart', 02:26:49 INFO - 'tscrollx', 02:26:49 INFO - 'cart']}, 02:26:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:49 INFO - 'tsvgr_opacity', 02:26:49 INFO - 'tart', 02:26:49 INFO - 'tscrollx', 02:26:49 INFO - 'cart']}, 02:26:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'talos_options': ['--disable-e10s'], 02:26:49 INFO - 'tests': ['tp5o']}, 02:26:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'tests': ['tp5o']}, 02:26:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'talos_options': ['--disable-e10s', 02:26:49 INFO - '--xperf_path', 02:26:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:49 INFO - 'tests': ['tp5n']}, 02:26:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:49 INFO - 'talos_options': ['--xperf_path', 02:26:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:49 INFO - 'tests': ['tp5n']}}, 02:26:49 INFO - 'talos.zip': {'path': '', 02:26:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:49 INFO - Running post-action listener: _resource_record_post_action 02:26:49 INFO - ##### 02:26:49 INFO - ##### Finished populate-webroot step (success) 02:26:49 INFO - ##### 02:26:49 INFO - ##### 02:26:49 INFO - ##### Running create-virtualenv step. 02:26:49 INFO - ##### 02:26:49 INFO - Running pre-action listener: _resource_record_pre_action 02:26:49 INFO - Running main action method: create_virtualenv 02:26:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:26:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:49 INFO - Using real prefix '/usr' 02:26:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:49 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:51 INFO - Installing pip.................done. 02:26:51 INFO - Return code: 0 02:26:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:26:51 INFO - Using env: {'DISPLAY': ':0', 02:26:51 INFO - 'HOME': '/home/cltbld', 02:26:51 INFO - 'LANG': 'en_US.UTF-8', 02:26:51 INFO - 'LANGUAGE': 'en_US:en', 02:26:51 INFO - 'LOGNAME': 'cltbld', 02:26:51 INFO - 'MAIL': '/var/mail/cltbld', 02:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:51 INFO - 'MOZ_NO_REMOTE': '1', 02:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:51 INFO - 'NO_EM_RESTART': '1', 02:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:51 INFO - 'PWD': '/builds/slave/test', 02:26:51 INFO - 'SHELL': '/bin/bash', 02:26:51 INFO - 'SHLVL': '1', 02:26:51 INFO - 'TERM': 'linux', 02:26:51 INFO - 'TMOUT': '86400', 02:26:51 INFO - 'USER': 'cltbld', 02:26:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:51 INFO - '_': '/tools/buildbot/bin/python'} 02:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:26:52 INFO - Cleaning up... 02:26:52 INFO - Return code: 0 02:26:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:52 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:26:52 INFO - Using env: {'DISPLAY': ':0', 02:26:52 INFO - 'HOME': '/home/cltbld', 02:26:52 INFO - 'LANG': 'en_US.UTF-8', 02:26:52 INFO - 'LANGUAGE': 'en_US:en', 02:26:52 INFO - 'LOGNAME': 'cltbld', 02:26:52 INFO - 'MAIL': '/var/mail/cltbld', 02:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:52 INFO - 'MOZ_NO_REMOTE': '1', 02:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:52 INFO - 'NO_EM_RESTART': '1', 02:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:52 INFO - 'PWD': '/builds/slave/test', 02:26:52 INFO - 'SHELL': '/bin/bash', 02:26:52 INFO - 'SHLVL': '1', 02:26:52 INFO - 'TERM': 'linux', 02:26:52 INFO - 'TMOUT': '86400', 02:26:52 INFO - 'USER': 'cltbld', 02:26:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:52 INFO - '_': '/tools/buildbot/bin/python'} 02:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:52 INFO - Downloading/unpacking psutil>=3.1.1 02:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:28:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:54 INFO - Installing collected packages: psutil 02:28:54 INFO - Running setup.py install for psutil 02:28:54 INFO - building 'psutil._psutil_linux' extension 02:28:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:28:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:28:55 INFO - building 'psutil._psutil_posix' extension 02:28:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:28:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:28:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:28:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:28:55 INFO - Successfully installed psutil 02:28:55 INFO - Cleaning up... 02:28:55 INFO - Return code: 0 02:28:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:55 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:28:55 INFO - Using env: {'DISPLAY': ':0', 02:28:55 INFO - 'HOME': '/home/cltbld', 02:28:55 INFO - 'LANG': 'en_US.UTF-8', 02:28:55 INFO - 'LANGUAGE': 'en_US:en', 02:28:55 INFO - 'LOGNAME': 'cltbld', 02:28:55 INFO - 'MAIL': '/var/mail/cltbld', 02:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:55 INFO - 'MOZ_NO_REMOTE': '1', 02:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:55 INFO - 'NO_EM_RESTART': '1', 02:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:55 INFO - 'PWD': '/builds/slave/test', 02:28:55 INFO - 'SHELL': '/bin/bash', 02:28:55 INFO - 'SHLVL': '1', 02:28:55 INFO - 'TERM': 'linux', 02:28:55 INFO - 'TMOUT': '86400', 02:28:55 INFO - 'USER': 'cltbld', 02:28:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:55 INFO - '_': '/tools/buildbot/bin/python'} 02:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:57 INFO - Installing collected packages: mozsystemmonitor 02:28:57 INFO - Running setup.py install for mozsystemmonitor 02:28:57 INFO - Successfully installed mozsystemmonitor 02:28:57 INFO - Cleaning up... 02:28:57 INFO - Return code: 0 02:28:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:57 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:28:57 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 02:28:57 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 02:28:57 INFO - Using env: {'DISPLAY': ':0', 02:28:57 INFO - 'HOME': '/home/cltbld', 02:28:57 INFO - 'LANG': 'en_US.UTF-8', 02:28:57 INFO - 'LANGUAGE': 'en_US:en', 02:28:57 INFO - 'LOGNAME': 'cltbld', 02:28:57 INFO - 'MAIL': '/var/mail/cltbld', 02:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:57 INFO - 'MOZ_NO_REMOTE': '1', 02:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:57 INFO - 'NO_EM_RESTART': '1', 02:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:57 INFO - 'PWD': '/builds/slave/test', 02:28:57 INFO - 'SHELL': '/bin/bash', 02:28:57 INFO - 'SHLVL': '1', 02:28:57 INFO - 'TERM': 'linux', 02:28:57 INFO - 'TMOUT': '86400', 02:28:57 INFO - 'USER': 'cltbld', 02:28:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:57 INFO - '_': '/tools/buildbot/bin/python'} 02:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:57 INFO - Downloading/unpacking jsonschema==2.5.1 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28: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 02:28:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:00 INFO - Downloading functools32-3.2.3-2.tar.gz 02:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:29:00 INFO - warning: no files found matching '*.txt' 02:29:00 INFO - no previously-included directories found matching 'build' 02:29:00 INFO - no previously-included directories found matching 'dist' 02:29:00 INFO - no previously-included directories found matching '.git*' 02:29:00 INFO - Installing collected packages: jsonschema, functools32 02:29:00 INFO - Running setup.py install for functools32 02:29:00 INFO - warning: no files found matching '*.txt' 02:29:00 INFO - no previously-included directories found matching 'build' 02:29:00 INFO - no previously-included directories found matching 'dist' 02:29:00 INFO - no previously-included directories found matching '.git*' 02:29:00 INFO - Successfully installed jsonschema functools32 02:29:00 INFO - Cleaning up... 02:29:00 INFO - Return code: 0 02:29:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:00 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:29:00 INFO - Using env: {'DISPLAY': ':0', 02:29:00 INFO - 'HOME': '/home/cltbld', 02:29:00 INFO - 'LANG': 'en_US.UTF-8', 02:29:00 INFO - 'LANGUAGE': 'en_US:en', 02:29:00 INFO - 'LOGNAME': 'cltbld', 02:29:00 INFO - 'MAIL': '/var/mail/cltbld', 02:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:00 INFO - 'MOZ_NO_REMOTE': '1', 02:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:00 INFO - 'NO_EM_RESTART': '1', 02:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:00 INFO - 'PWD': '/builds/slave/test', 02:29:00 INFO - 'SHELL': '/bin/bash', 02:29:00 INFO - 'SHLVL': '1', 02:29:00 INFO - 'TERM': 'linux', 02:29:00 INFO - 'TMOUT': '86400', 02:29:00 INFO - 'USER': 'cltbld', 02:29:00 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:00 INFO - '_': '/tools/buildbot/bin/python'} 02:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:00 INFO - Downloading/unpacking blobuploader==1.2.4 02:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:02 INFO - Downloading blobuploader-1.2.4.tar.gz 02:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:29:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:03 INFO - Downloading docopt-0.6.1.tar.gz 02:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:03 INFO - Running setup.py install for blobuploader 02:29:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:03 INFO - Running setup.py install for requests 02:29:03 INFO - Running setup.py install for docopt 02:29:03 INFO - Successfully installed blobuploader requests docopt 02:29:03 INFO - Cleaning up... 02:29:03 INFO - Return code: 0 02:29:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:03 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:03 INFO - Using env: {'DISPLAY': ':0', 02:29:03 INFO - 'HOME': '/home/cltbld', 02:29:03 INFO - 'LANG': 'en_US.UTF-8', 02:29:03 INFO - 'LANGUAGE': 'en_US:en', 02:29:03 INFO - 'LOGNAME': 'cltbld', 02:29:03 INFO - 'MAIL': '/var/mail/cltbld', 02:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:03 INFO - 'MOZ_NO_REMOTE': '1', 02:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:03 INFO - 'NO_EM_RESTART': '1', 02:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:03 INFO - 'PWD': '/builds/slave/test', 02:29:03 INFO - 'SHELL': '/bin/bash', 02:29:03 INFO - 'SHLVL': '1', 02:29:03 INFO - 'TERM': 'linux', 02:29:03 INFO - 'TMOUT': '86400', 02:29:03 INFO - 'USER': 'cltbld', 02:29:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:03 INFO - '_': '/tools/buildbot/bin/python'} 02:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:04 INFO - Running setup.py (path:/tmp/pip-wG54mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:04 INFO - Running setup.py (path:/tmp/pip-HApohR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:04 INFO - Running setup.py (path:/tmp/pip-FBv95F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:04 INFO - Running setup.py (path:/tmp/pip-AJHIw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:04 INFO - Running setup.py (path:/tmp/pip-PdfnVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:04 INFO - Running setup.py (path:/tmp/pip-pIBfYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:04 INFO - Running setup.py (path:/tmp/pip-IkiE1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:04 INFO - Running setup.py (path:/tmp/pip-75qxdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:04 INFO - Running setup.py (path:/tmp/pip-TU7cjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:04 INFO - Running setup.py (path:/tmp/pip-4pnX46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:04 INFO - Running setup.py (path:/tmp/pip-a_nAmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:04 INFO - Running setup.py (path:/tmp/pip-VylxEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:04 INFO - Running setup.py (path:/tmp/pip-QjQNZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:04 INFO - Running setup.py (path:/tmp/pip-w23SHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:05 INFO - Running setup.py (path:/tmp/pip-g6QtY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:05 INFO - Running setup.py (path:/tmp/pip-fwNZHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:05 INFO - Running setup.py (path:/tmp/pip-OX5hbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:05 INFO - Running setup.py install for manifestparser 02:29:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Running setup.py install for mozcrash 02:29:05 INFO - Running setup.py install for mozdebug 02:29:05 INFO - Running setup.py install for mozdevice 02:29:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Running setup.py install for mozfile 02:29:05 INFO - Running setup.py install for mozhttpd 02:29:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Running setup.py install for mozinfo 02:29:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:05 INFO - Running setup.py install for mozInstall 02:29:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for mozleak 02:29:06 INFO - Running setup.py install for mozlog 02:29:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for moznetwork 02:29:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for mozprocess 02:29:06 INFO - Running setup.py install for mozprofile 02:29:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for mozrunner 02:29:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:06 INFO - Running setup.py install for mozscreenshot 02:29:06 INFO - Running setup.py install for moztest 02:29:06 INFO - Running setup.py install for mozversion 02:29:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:07 INFO - Cleaning up... 02:29:07 INFO - Return code: 0 02:29:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:07 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:07 INFO - Using env: {'DISPLAY': ':0', 02:29:07 INFO - 'HOME': '/home/cltbld', 02:29:07 INFO - 'LANG': 'en_US.UTF-8', 02:29:07 INFO - 'LANGUAGE': 'en_US:en', 02:29:07 INFO - 'LOGNAME': 'cltbld', 02:29:07 INFO - 'MAIL': '/var/mail/cltbld', 02:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:07 INFO - 'MOZ_NO_REMOTE': '1', 02:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:07 INFO - 'NO_EM_RESTART': '1', 02:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:07 INFO - 'PWD': '/builds/slave/test', 02:29:07 INFO - 'SHELL': '/bin/bash', 02:29:07 INFO - 'SHLVL': '1', 02:29:07 INFO - 'TERM': 'linux', 02:29:07 INFO - 'TMOUT': '86400', 02:29:07 INFO - 'USER': 'cltbld', 02:29:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:07 INFO - '_': '/tools/buildbot/bin/python'} 02:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:07 INFO - Running setup.py (path:/tmp/pip-B2uDFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:07 INFO - Running setup.py (path:/tmp/pip-A4Y1QC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:07 INFO - Running setup.py (path:/tmp/pip-MoGkWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:07 INFO - Running setup.py (path:/tmp/pip-tv8p5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:07 INFO - Running setup.py (path:/tmp/pip-1mbdpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:07 INFO - Running setup.py (path:/tmp/pip-2ZTQOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:07 INFO - Running setup.py (path:/tmp/pip-WmXNVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:07 INFO - Running setup.py (path:/tmp/pip-c7CrCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:07 INFO - Running setup.py (path:/tmp/pip-B4hP9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:07 INFO - Running setup.py (path:/tmp/pip-pmIMER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:07 INFO - Running setup.py (path:/tmp/pip-5bAKV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:08 INFO - Running setup.py (path:/tmp/pip-5m54gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:08 INFO - Running setup.py (path:/tmp/pip-JC3wtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:08 INFO - Running setup.py (path:/tmp/pip-jx65ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:08 INFO - Running setup.py (path:/tmp/pip-x9mnGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:08 INFO - Running setup.py (path:/tmp/pip-XNDU7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:08 INFO - Running setup.py (path:/tmp/pip-zzJS4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:10 INFO - Downloading blessings-1.6.tar.gz 02:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:10 INFO - Installing collected packages: blessings 02:29:10 INFO - Running setup.py install for blessings 02:29:10 INFO - Successfully installed blessings 02:29:10 INFO - Cleaning up... 02:29:10 INFO - Return code: 0 02:29:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:10 INFO - Reading from file tmpfile_stdout 02:29:10 INFO - Current package versions: 02:29:10 INFO - argparse == 1.2.1 02:29:10 INFO - blessings == 1.6 02:29:10 INFO - blobuploader == 1.2.4 02:29:10 INFO - docopt == 0.6.1 02:29:10 INFO - functools32 == 3.2.3-2 02:29:10 INFO - jsonschema == 2.5.1 02:29:10 INFO - manifestparser == 1.1 02:29:10 INFO - mozInstall == 1.12 02:29:10 INFO - mozcrash == 0.17 02:29:10 INFO - mozdebug == 0.1 02:29:10 INFO - mozdevice == 0.48 02:29:10 INFO - mozfile == 1.2 02:29:10 INFO - mozhttpd == 0.7 02:29:10 INFO - mozinfo == 0.9 02:29:10 INFO - mozleak == 0.1 02:29:10 INFO - mozlog == 3.2 02:29:10 INFO - moznetwork == 0.27 02:29:10 INFO - mozprocess == 0.22 02:29:10 INFO - mozprofile == 0.28 02:29:10 INFO - mozrunner == 6.11 02:29:10 INFO - mozscreenshot == 0.1 02:29:10 INFO - mozsystemmonitor == 0.3 02:29:10 INFO - moztest == 0.7 02:29:10 INFO - mozversion == 1.4 02:29:10 INFO - psutil == 3.1.1 02:29:10 INFO - requests == 1.2.3 02:29:10 INFO - wsgiref == 0.1.2 02:29:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:10 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:10 INFO - Using env: {'DISPLAY': ':0', 02:29:10 INFO - 'HOME': '/home/cltbld', 02:29:10 INFO - 'LANG': 'en_US.UTF-8', 02:29:10 INFO - 'LANGUAGE': 'en_US:en', 02:29:10 INFO - 'LOGNAME': 'cltbld', 02:29:10 INFO - 'MAIL': '/var/mail/cltbld', 02:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:10 INFO - 'MOZ_NO_REMOTE': '1', 02:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:10 INFO - 'NO_EM_RESTART': '1', 02:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:10 INFO - 'PWD': '/builds/slave/test', 02:29:10 INFO - 'SHELL': '/bin/bash', 02:29:10 INFO - 'SHLVL': '1', 02:29:10 INFO - 'TERM': 'linux', 02:29:10 INFO - 'TMOUT': '86400', 02:29:10 INFO - 'USER': 'cltbld', 02:29:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:10 INFO - '_': '/tools/buildbot/bin/python'} 02:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:29:11 INFO - Cleaning up... 02:29:11 INFO - Return code: 0 02:29:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:11 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:29:11 INFO - Using env: {'DISPLAY': ':0', 02:29:11 INFO - 'HOME': '/home/cltbld', 02:29:11 INFO - 'LANG': 'en_US.UTF-8', 02:29:11 INFO - 'LANGUAGE': 'en_US:en', 02:29:11 INFO - 'LOGNAME': 'cltbld', 02:29:11 INFO - 'MAIL': '/var/mail/cltbld', 02:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:11 INFO - 'MOZ_NO_REMOTE': '1', 02:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:11 INFO - 'NO_EM_RESTART': '1', 02:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:11 INFO - 'PWD': '/builds/slave/test', 02:29:11 INFO - 'SHELL': '/bin/bash', 02:29:11 INFO - 'SHLVL': '1', 02:29:11 INFO - 'TERM': 'linux', 02:29:11 INFO - 'TMOUT': '86400', 02:29:11 INFO - 'USER': 'cltbld', 02:29:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:11 INFO - '_': '/tools/buildbot/bin/python'} 02:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:29:11 INFO - Cleaning up... 02:29:11 INFO - Return code: 0 02:29:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:11 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 0x7fac1f1cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, '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': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:29:11 INFO - Using env: {'DISPLAY': ':0', 02:29:11 INFO - 'HOME': '/home/cltbld', 02:29:11 INFO - 'LANG': 'en_US.UTF-8', 02:29:11 INFO - 'LANGUAGE': 'en_US:en', 02:29:11 INFO - 'LOGNAME': 'cltbld', 02:29:11 INFO - 'MAIL': '/var/mail/cltbld', 02:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:11 INFO - 'MOZ_NO_REMOTE': '1', 02:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:11 INFO - 'NO_EM_RESTART': '1', 02:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:11 INFO - 'PWD': '/builds/slave/test', 02:29:11 INFO - 'SHELL': '/bin/bash', 02:29:11 INFO - 'SHLVL': '1', 02:29:11 INFO - 'TERM': 'linux', 02:29:11 INFO - 'TMOUT': '86400', 02:29:11 INFO - 'USER': 'cltbld', 02:29:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:11 INFO - '_': '/tools/buildbot/bin/python'} 02:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:11 INFO - Downloading/unpacking flake8 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:29:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:29:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:14 INFO - no previously-included directories found matching 'docs/_build' 02:29:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:29:14 INFO - Running setup.py install for pep8 02:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:14 INFO - no previously-included directories found matching 'docs/_build' 02:29:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:29:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:29:14 INFO - Cleaning up... 02:29:14 INFO - Return code: 0 02:29:14 INFO - Running post-action listener: _resource_record_post_action 02:29:14 INFO - Running post-action listener: _start_resource_monitoring 02:29:14 INFO - Starting resource monitoring. 02:29:14 INFO - ##### 02:29:14 INFO - ##### Finished create-virtualenv step (success) 02:29:14 INFO - ##### 02:29:14 INFO - ##### 02:29:14 INFO - ##### Running install step. 02:29:14 INFO - ##### 02:29:14 INFO - Running pre-action listener: _resource_record_pre_action 02:29:14 INFO - Running main action method: install 02:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:14 INFO - Reading from file tmpfile_stdout 02:29:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:14 INFO - Reading from file tmpfile_stdout 02:29:14 INFO - Output received: 02:29:14 INFO - Usage: mozinstall [options] installer 02:29:14 INFO - Options: 02:29:14 INFO - -h, --help show this help message and exit 02:29:14 INFO - -d DEST, --destination=DEST 02:29:14 INFO - Directory to install application into. [default: 02:29:14 INFO - "/builds/slave/test"] 02:29:14 INFO - --app=APP Application being installed. [default: firefox] 02:29:14 INFO - mkdir: /builds/slave/test/build/application 02:29:14 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'] 02:29:14 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 02:29:30 INFO - Reading from file tmpfile_stdout 02:29:30 INFO - Output received: 02:29:30 INFO - /builds/slave/test/build/application/firefox/firefox 02:29:30 INFO - Running post-action listener: _resource_record_post_action 02:29:30 INFO - ##### 02:29:30 INFO - ##### Finished install step (success) 02:29:30 INFO - ##### 02:29:30 INFO - ##### 02:29:30 INFO - ##### Running run-tests step. 02:29:30 INFO - ##### 02:29:30 INFO - Running pre-action listener: _resource_record_pre_action 02:29:30 INFO - Running main action method: run_tests 02:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:29:30 INFO - Python 2.7.3 02:29:30 INFO - Return code: 0 02:29:30 INFO - grabbing minidump binary from tooltool 02:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:30 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 0x25421c0>, '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 0x25430c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2543550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:29:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:29:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:29:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:29:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:29:30 INFO - Return code: 0 02:29:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:29:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:29:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:29:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:29:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:29:31 INFO - Return code: 0 02:29:31 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:29:31 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:29:31 INFO - Using env: {'DISPLAY': ':0', 02:29:31 INFO - 'HOME': '/home/cltbld', 02:29:31 INFO - 'LANG': 'en_US.UTF-8', 02:29:31 INFO - 'LANGUAGE': 'en_US:en', 02:29:31 INFO - 'LOGNAME': 'cltbld', 02:29:31 INFO - 'MAIL': '/var/mail/cltbld', 02:29:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:29:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:31 INFO - 'MOZ_NO_REMOTE': '1', 02:29:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:29:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:31 INFO - 'NO_EM_RESTART': '1', 02:29:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:31 INFO - 'PWD': '/builds/slave/test', 02:29:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:29:31 INFO - 'SHELL': '/bin/bash', 02:29:31 INFO - 'SHLVL': '1', 02:29:31 INFO - 'TERM': 'linux', 02:29:31 INFO - 'TMOUT': '86400', 02:29:31 INFO - 'USER': 'cltbld', 02:29:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174', 02:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:31 INFO - '_': '/tools/buildbot/bin/python'} 02:29:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:29:31 INFO - mozversion application_buildid: 20160606202128 02:29:31 INFO - mozversion application_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:29:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:29:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:29:31 INFO - mozversion application_name: Firefox 02:29:31 INFO - mozversion application_remotingname: firefox-dev 02:29:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:31 INFO - mozversion application_vendor: Mozilla 02:29:31 INFO - mozversion application_version: 49.0a2 02:29:31 INFO - mozversion platform_buildid: 20160606202128 02:29:31 INFO - mozversion platform_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:29:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:29:31 INFO - mozversion platform_version: 49.0a2 02:29:31 INFO - using testdate: 1465291771 02:29:31 INFO - actual date: 1465291771 02:29:31 INFO - starting webserver on 'localhost:39978' 02:29:31 INFO - SUITE-START | Running 2 tests 02:29:31 INFO - TEST-START | dromaeo_css 02:29:31 INFO - operating with platform_type : linux_ 02:29:31 INFO - Initialising browser for dromaeo_css test... 02:29:31 INFO - TEST-INFO | started process 13142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpub5EGS/profile http://localhost:39978/getInfo.html) 02:29:35 INFO - PROCESS | 13142 | __metrics Screen width/height:1600/1200 02:29:35 INFO - PROCESS | 13142 | colorDepth:24 02:29:35 INFO - PROCESS | 13142 | Browser inner width/height: 1024/697 02:29:35 INFO - PROCESS | 13142 | __metrics 02:29:36 ERROR - PROCESS | 13142 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:29:37 INFO - PROCESS | 13142 | console.error: PushService: 02:29:37 INFO - PROCESS | 13142 | stateChangeProcessEnqueue: Error transitioning state 02:29:37 INFO - PROCESS | 13142 | UnknownError 02:29:37 INFO - TEST-INFO | 13142: exit 0 02:29:37 INFO - Browser initialized. 02:29:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:29:37 INFO - TEST-INFO | started process 13233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpub5EGS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:49 INFO - PROCESS | 13233 | RSS: Main: 145047552 02:29:49 INFO - PROCESS | 13233 | 02:30:40 INFO - PROCESS | 13233 | 1465291840954 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:32:48 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:39978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39978/tests/dromaeo/cssquery-ext.html) 02:32:50 INFO - PROCESS | 13233 | RSS: Main: 257015808 02:32:50 INFO - PROCESS | 13233 | 02:35:52 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:39978/tests/dromaeo/cssquery-ext.html (next: http://localhost:39978/tests/dromaeo/cssquery-jquery.html) 02:35:52 INFO - PROCESS | 13233 | RSS: Main: 231768064 02:35:52 INFO - PROCESS | 13233 | 02:38:54 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:39978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39978/tests/dromaeo/cssquery-mootools.html) 02:38:55 INFO - PROCESS | 13233 | RSS: Main: 218525696 02:38:55 INFO - PROCESS | 13233 | 02:41:57 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:39978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39978/tests/dromaeo/cssquery-prototype.html) 02:41:57 INFO - PROCESS | 13233 | RSS: Main: 222199808 02:41:57 INFO - PROCESS | 13233 | 02:45:00 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:39978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39978/tests/dromaeo/cssquery-yui.html) 02:45:01 INFO - PROCESS | 13233 | RSS: Main: 217579520 02:45:01 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | Cycle 1(1): loaded http://localhost:39978/tests/dromaeo/cssquery-yui.html (next: http://localhost:39978/tests/dromaeo/cssquery-dojo.html) 02:48:03 INFO - PROCESS | 13233 | RSS: Main: 265801728 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | __start_tp_report 02:48:03 INFO - PROCESS | 13233 | _x_x_mozilla_page_load 02:48:03 INFO - PROCESS | 13233 | _x_x_mozilla_page_load_details 02:48:03 INFO - PROCESS | 13233 | |i|pagename|runs| 02:48:03 INFO - PROCESS | 13233 | |0;dojo.html;3373.021823671135;3414.470757032659;3415.9487607685874;3432.2792213635134;3463.5843698756153;5700.686462244575;5782.045962416201;5798.217240672508;5819.476247137757;5842.152887831262;5680.886382272352;5702.087665973445;5710.942890571093;5711.371749107605;5719.828405147842;5140.0490909181735;5157.020166168425;5160.225966105096;5193;5198.636095473318;5246.1868410396255;5268.262443257928;5295.0468915595175;5299.49654782795;5319.840404787863;5194.065068287707;5257.158854583267;5261.421243663194;5283.07546179419;5306.071437498442;5344.518993290603;5353.973230133864;5354.705491198021;5356.35723713153;5361.731913404315;5017.347744793154;5126.256692779526;5175.327207463006;5224.686518808883;5231.633785635007;5554.333479982428;5584.21820945068;5584.246126772915;5638.182463542763;5646.463585959327;6163.537734669918;6169.537284703621;6176.722047507873;6177.536684748662;6178.567500274982;6090.086487026937;6155.876882462326;6158.076288556707;6202.100695399187;6225.564210505267;5793.565482588822;5802.97098514509;5836.503897168745;5836.854078648025;5840.386759390203;6048.788292409745;6357.650329231937;6364.077208804697;6365.458935990493;6368.713407896563;5962.314333851663;6047.213862197974;6059.6364218147055;6106.389361063858;6109.236345456818;6181.258249010148;6189.876202475925;6190.938090619126;6194.194754681863;6201.503879689614;5778.624389414758;5915.792947246826;6059.424354686298;6075.453209211104;6075.756969721162;6064.605800622945;6115.879294474695;6117.309816958451;6132.4166970161305;6139.522803442322;4620.861374158713;4652.418447694038;4654.930176047362;4674.696144750648;4678.719276843332;4097.610726980932;4108.876733697994;4154.044569748975;4158.7296825706835;4170.562090980464;5894.145348924468;5904.4685978261305;5905.586608937333;5906.3207731110615;5930.614510056833;6198.845028874224;6229.626222426669;6248.5313601479165;6249.500039996789;6258.655773932386;5703.8859222816145;5723.399043100498;5815.214945982323;5825.854353641193;5887.646741195542;5314.601404894571;5320.1753728171425;5320.654157479751;5324.334458192726;5324.787008519694;6434.163558737334;6449.580777249464;6453.290138084807;6458.709358078898;6463.385978332051;6018.488428483628;6030.246219222598;6084.056971169476;6121.571489995657;6157.26112866441;6331.303556608861;6345.079963405188;6345.809625711236;6363.809085727436;6386.457151142019;6009.06859436788;6062.848428789315;6063.181470501426;6066.696665166813;6073.939260607514;6016.398360164124;6059.0608455689435;6111.419415155553;6133.233345831771;6151.141477252921;5985.610935289193;5985.700714964321;5986.461218490357;6020.096985452217;6036.849078773066;5759.04975679025;5924.851878702894;5995.640261584319;6000.159977603226;6002.669853158118;5826.854328641818;5895.29256489224;5900.321463031806;5964.463198312173;5970.58205925581;6125.607917153528;6128.111423843607;6131.277598982041;6132.08018797184;6134.9079763804475;5756.94243057564;5887.8233652990475;5995.670238136944;5996.610220335664;6016.458518733335 02:48:03 INFO - PROCESS | 13233 | |1;ext.html;602.1569802276812;654.3195077119794;656.3010393930464;661.1438187547129;666.726642076748;33197;35833.1041723957;35884.641153588454;35900.10249743755;35982.100447488796;37035.25929481409;37663.24673506528;37788;48721.756391218085;49402;9142.542872856347;9341.95329023354;9342.532873356338;9343.392679475812;9346.81306373872;9141.31440141992;9323;9325.86011209829;9328.06719328065;9339;8603.268722158624;8850.070742572034;8856.070112638177;9085.318601104911;11033.172512061587;10878.564857405694;11258.04306633937;11278.661640150767;11310.773784524263;11317.094632429385;11095.944520277428;11175.050120739746;11189.552417903275;11193.384363859985;11197.66407007791;34906;44973.10053798938;45653;46666;46685.53314466846;3960.782156981365;4096.631303182728;4452.732836029816;4554.453465584151;4622.260438329885;35835.28329433397;35924.64075359239;36001;36055.4591681125;36115.638843611494;4307.655387568987;4342;4355;4362.760048197348;4416.6025057744955;396717;399147;399988;400351;400409;39388.803055984536;40826.38760418596;40879.182416351505;42727.35908961368;70700.2929970704;42982.57017429848;42992.35511467331;43028.13943721108;43149;43218.351724724154;17208.225629846685;17262.827371726373;17355;17375.04437255963;17377;14065.929670351583;14105.647358815906;14111.294435278194;14116.50592229267;14234.217118058607;9489.718887950177;9593.808123837483;9660.420374777535;9711.27165462579;9738.707838764849;3416.8974930752115;3582.17609949713;3687.90780230491;3705.9258814824093;3746.981265093657;1052.2634156090614;1052.7789164275434;1094.43089593411;1143.6912033751007;1161.2103769436865;33811.4928276076;34344.48483272753;34898.30203395918;34993.30013399768;35338;1174.7591743692522;1181.0374544746005;1234.3334599316447;1249.900007999358;1253.9122261441612;16572.254248558846;17128.14359282031;17242.913785431243;17284.827151728572;17351.43837054671;628705;634981;635537;635846;637346;56950;57925.131123033185;63170.68414657989;63687;63890.68054659697;1401.6495876030992;1434.3402035063987;1438.697873446567;1438.7841823726524;1440.9783853242209;33787;34175.316493670485;34946;35090.473642895886;35129.64870351264;55078.173827391816;55714.72142639261;55721.44278557163;55736.72131639316;55821.44178558325;455315;459553;567091;569264;588042;31495.84252078725;31575;31612.841935790173;31752;31947;51589.22616160686;52888.471115288354;53470;53748.19377709416;54300.185497218365;44166.55833441753;44866.77566612146;45939.54060459352;48843.5115648839;49654.75172624258;44582;45381.54618453773;45647.77176114231;45797;46601.06797864092;44923.550764491934;45324.54675453335;45872;46118.538814612766;46231.53768462272;38627;40001;40259.1948161041;40962.79518602388;41315.1736965265;30402.39195216039;30519.237019074702;30567.2358191047;30681;30928.0721578353 02:48:03 INFO - PROCESS | 13233 | |2;jquery.html;432.9415528903598;435.301341347138;435.5254451544092;436.1647445142551;440.66729619137544;17532.56168595784;18016.279348826032;18933;18980.430587082374;19002.61994760104;18099.63800723988;18476.260949562035;18619.906900465514;18667.626647467077;18689.252429902786;5505.587080968933;5940.19807326012;5941.0494320908665;5943.049112142058;5944.256967879015;5835.912461313083;5837.970810145944;5900.380460051697;5900.498457631085;5902.144189092601;5681.091025435931;5809.970950145264;5837.066069428893;5838.737256823453;5849.64902105875;5445.292112025411;5756.481916627482;5812.680302583356;5815.912761308584;5820.039693450575;5457.099578569571;5643.633163844337;5678;5679.807240479504;5680.857978550528;14565.708685826225;14802.481913132988;14818;14821.851781482155;16616.916915415466;2295.3802473332275;2509.4353770401513;2580.522603318392;2680.5711086226306;2789.8744556495008;10401.79196416075;10481.266311358208;10483.842742358871;10884;10928.890711092867;1988.8906110163934;2023.5750492396614;2040.8571400002006;2047.1504325704814;2064.669652855551;62452.383199153664;85519.57240213822;85747.57126214329;85963.14036859614;86151.13848861493;11430.028447582048;11500.88499115015;11501.884981150082;11604;11820.76358472843;16341.264643090852;16395.508134755975;16491.09298988543;16507.257173427224;16517.504474865775;7881.408894332948;8106.270435660819;8142.674293028331;8152.307053900485;8184.54984975832;8136.7152149674475;8176.83646327082;8184.549849758201;8211.7947051323;8227.794305142299;4773;4797.18447863864;4851.490593487703;4946.653734238641;5005.249212618136;2069.4826293426645;2076.688496725473;2077.2729544659246;2102.117110813462;2135.6689713094497;920.8664743612272;941.261110028638;977.7066879935991;999.0509016434416;1091.9344839309667;18000.369987050653;18101;18269.269229230682;19014.334498292494;19284.710729339073;988.4464699768153;1021.7088129882948;1027.4862568715641;1045.7803861189084;1077.8167711489066;8092.635831387602;10077.59689612422;10582.894171058344;10647.23344684831;10836.891631083747;412266;413091;413670;569672;580863;103387.48306258571;103745;106821;107095;109312;1058.2962330050584;1065.9626913058005;1084.7450849050624;1092.9890701093045;1105.834124881258;17166.22751976189;17398.73901891498;17479.737803933207;17577.121143942495;17834.46496605104;37715.43426848545;42497.5750242506;43842;44150.55849441465;44465.11069778651;54798.45201548093;61693.69153154385;63028.36971630225;63385.19688818686;63576.68211658912;7922.128565857866;8220.83558328842;8295.170482951657;8791.076936921787;9163.129502697233;10516;13105.475780969036;13634.727305453636;13688.384022718803;14212;12303.323317217639;12453.688657783629;12458.439370228543;12514.499420023098;12583;11709.707257318636;12197.268163910194;12446.875531244572;12527.812082818948;12560.560380387009;12456.12807103494;12518.311492867979;12735.936320318338;12797.936010319889;13054.477820887058;9062.093790620886;9393.577289022147;9476.099770521789;12431.502739890304;13249.867501324863;11834.171607987359;11973.461194246454;12160.817587736014;12356;12523.874761252271 02:48:03 INFO - PROCESS | 13233 | |3;mootools.html;1449;1551.4880089570443;1592.2755146408383;1797.5955410032736;1922.5578117033083;9032.051634578373;9489.667861624845;9535.666251681192;9738.659146929858;9750.70747877563;9520.666776662818;9564.330496865205;9627.470489123096;9638.710838674851;9642.517874106285;2117.5553133841913;2384.2966324934187;2476.5913624251975;2501.4746903150362;2504.3488692939786;2426.1265944260053;2450.3384086296687;2451.166603354859;2451.8774061296954;2452.080469823816;2440.487497625492;2458.9754102458924;2469.4814089041324;2470.5923522618746;2471.2462698876834;2080.6358887194756;2324.5118525109747;2375.085592047066;2421.6367544868235;2424.866632335221;2422.1280339077916;2447.4615584571366;2451.497443024176;2455.177515532299;2459.631055341695;9563.282753793494;9627.229821614254;9629;9633.277504187145;9635;5398.514133727944;5507.7246137693355;5510.118381059011;5510.201020851994;5515.806946756885;3503.1067077895227;3510.929781404383;3570.1788588624504;3584.390653588896;3621.4567814827724;1114.3703807348902;1135.233717240859;1142.0692135909208;1166.381817636654;1175.3887978251262;12663.113582049353;12670.619881403572;12691.873081269161;12697.174683645533;12711.61865144038;4861;4907.68100073494;4979.90040199194;4986.227134794112;4986.626003049713;10477.47612619366;10491.055804977588;10578.153747700166;10600.257981941344;10616.575336986589;5574.581906356958;5577.553795696334;5580.553555715533;5586.329640443173;5637.23897273871;4572.885677858014;5180.145276029489;5353.785848566092;5368.436314187033;5436.53789427903;4335.393044973706;4374.125174964956;4425.845095421645;4455.220336441174;4478.171538265431;1343.6640839790052;1354.634248752851;1359.8708122728524;1360.2926478231263;1378.2970684950747;909.2089881802874;985.6156099121348;1046.1892033673964;1054.0513537816028;1064.8775390829999;6295.653739044396;6324.683765811691;6409.935900640934;6496.415322620986;6504.382083702136;462.1819379697916;467.6679557514135;469.0571950379761;470.9481956984729;500.07236576150717;4230.280852255124;4381.978090109529;4427.601515863524;4432.002799370116;4432.667549933703;10826.512806923707;11918.642440726791;12322.876771232173;12408.069394795426;12449.502019919102;11401.828972565418;11416.20086593947;11563.88436115628;11692.824607630891;11832.704182395337;8797.29621630268;9064.138906803842;9075.273978081737;9078.54607269634;9084.818973533398;6492.156019717407;6693.330666933268;6763.695633696397;6914.377706006484;6929.133858267716;10897.618583349862;10976.835347469954;11061.612843550438;11085.168612353944;11170.832437513282;11193.160512961398;11270.887291126985;11370.488328025092;11394.601188958679;11408.714782130513;7564.130125035691;7755.883661745192;8549.187827156658;8642.870356944777;8649.697260595849;9570.330076894828;9604.615815367308;9635.421874687541;9683.66107186245;9694.75763105928;8379.664813407395;8462.576871156294;8627.309815214894;8671;8841.69054083104;8435;8533.53065581399;8572.3999320047;8617.612207450555;8705.434146780439;7760.18518055596;7844.450888437755;7860.528368297921;7868.803279918048;7874.803129921798;5662.688552129673;5666.46168613981;5774.700692344189;5808.07070868659;5983.521318294439;5791.797287094932;5837.883242335214;5871.882562348815;5879.853003674943;5902.61632993854 02:48:03 INFO - PROCESS | 13233 | |4;prototype.html;350.3133857639027;357.027101149368;357.72276485723563;359.7212160575552;363.6817784438616;5573.247611572437;5633.521150702195;5641.2384328115695;5671.914921276179;5684.294711586528;5569.136783798518;5573.916391254134;5591.6365436246715;5592.8255066435995;5594.720263986795;4188.162367526499;4341.153475072362;4355.455568053993;4386.473623165225;4404.4494438195225;4356.455443069616;4366.323219900921;4367.908022994251;4391.473023237216;4402.889927751799;4331.285337919256;4359.847405340814;4385.890352741175;4391.341298805189;4405.383246345515;4117.938230926524;4318.740875547477;4340.52254252032;4344.218040752663;4371.060222052258;3766.5291838520184;3800.771953682788;3806.410006449005;3819.1216020315205;3826.253880493305;5370.489803468664;5415.241866138744;5444.836654900319;5450.427705090988;5533.114701647757;4839.419269687624;4963.80868591539;4982.60139188864;4994.500549945013;5012.699238045729;5801.477866991991;5808.157817116495;5810.854728631776;5816.789619944394;5845;4217.650351887397;4244.9151016979795;4255.404243405895;4257.1485702859245;4278.721883077621;5654.434556544354;5821.767129314865;5922.615030023077;6026.8493287667725;6129.509639228851;4299;4300.978495107567;4302.9569704303185;4320.589543993316;4331.480222373272;4298.118885628439;4316.330968699856;4317.978410107992;4357.888738371695;4361.890952726144;4770.141374552544;4844.709317440965;4942.827001055018;4962.528559786814;4980.501949805063;5832.650040997553;5847.678377689268;5866.794662186803;5887.911681324784;5889.234399528034;1491.6942026884462;1510.4335874047233;1512.6445285357931;1515.181801827023;1515.1893736850732;943.6272672294542;957.6935380678116;960.1550635440767;964.609333220033;964.7009427077628;4923.926141107886;5067.986402719471;5075.492450754969;5118.846434606968;5135.97432012845;5302.2311764793885;5303.939212157584;5399.271098401744;5416.891662166813;5424.728763561806;5169.759257778106;5197.480251974772;5396.757145928443;5807.593468457168;5848.912266315923;3165.572647692578;3205.5191721241536;3206.615206175274;3226.2579606690592;3232;6106.877862442726;6233.470155036873;6244.625322480666;6256.249250090018;6311.495080393557;6174.135621013062;6183.57777711129;6185.165002724664;6188.628682279078;6202.81391558254;6211.173915868269;6272.968635156795;6324.936750632527;6352.555321127476;6385.584936979081;5868.2664666916635;6116.602420842631;6155.507559395327;6188.5864512839125;6190.628562286277;5793.217915581511;6079.848003799763;6089.908651370321;6104.786332478342;6107.358727333566;6082.482988945989;6238.189035425366;6247.687615619292;6257.374262573889;6258.93455159787;4286.764227967367;4340.587644173798;4343.913121737611;4348.499922508826;4355.107203023436;5799.188113664006;6098.5426093042315;6119.755209791559;6128.111423843607;6146.692665366624;5819.970900145472;5874.471297583067;5942.970285148546;5954.779270249675;5969.671668058299;5679.290088738908;5900.321463031806;5926.407359264212;5934.732937017759;5934.910976335272;5751.223584816164;5783.913241301299;5785.537157027512;5804.506616937608;5808.6224395414165;5912.906112369225;5913.349531551612;5942.346341902474;5977;5991.490723288395;5704.743286552198;5788.797392091256;5823.699638642628;5834.970825145847;5878.911816322673 02:48:03 INFO - PROCESS | 13233 | |5;yui.html;815.5759005317235;824.3281725393804;832.0223737108897;853.7481442974324;900.5227229568331;15489.14809685467;17924.193411296492;17929.282828686853;17939.192736326862;17979.73030404545;16166.353345866151;16183.514494565152;16221;16241.431549895757;16620.418285359985;755.6221889055458;874.9737507874773;895.5880295064246;896.5651658945407;906.1074841281333;894.217559635319;902.5081330674765;903.0517956146053;903.1420150856679;903.7062954539768;791.4499422901087;926.0785518409192;942.2697409507618;945.3760518058083;960.6397600899662;940.1773448232797;941.5245301122958;941.5857022909897;941.6704153546273;943.3349488610513;690.8031211104861;691.2810676896022;691.3017851969497;691.4848437913736;691.5193940211554;16657.33370665172;16699.83300166995;16703.498895033168;16709.331626734915;16727.665446690997;14401.279936003262;14498.855011449961;14582.854171458255;14650.120992740469;14705.852941470663;13722.45110195601;13817;13976.440942362293;13985.230812305319;13989.790153147711;4691.577758001762;4727;4730.621550276004;4755.904881902377;4841.8063277468855;75574.62212688901;75841;77098.84351734785;77400;77674.22325776727;12033.578824741093;12118.939405302917;12173.2696038238;12232.81650775239;12352;21761.673574896387;21770.455738606663;21814.781852181273;21832.45418864541;21918.89040554819;8750.212480876624;8768.430052046597;8798.736037918872;8949.149830766068;9015.323850711224;5121.155009423478;5128.410232823198;5216.58267338612;5245.396779370345;5290.947090529045;3458.3774920514047;3832.080300727805;3971.1859068891386;3991.261616600938;4108.753474791522;732.2860211294052;735.797655644702;736.3998341351781;745.6868115391549;749.6851322444586;661.7022339947043;727.9735572842267;769.4498433619989;788.8501184774874;791.8218400859761;10768.3538987661;10827.24209305341;10975.50610222542;11012.39431831257;11156.665300041012;665.2084020016165;681.0873429604255;729.1687476277049;812.2243257688893;822.1860358245294;5365.8390248291835;5385.264693101913;5604.41153678866;5610.382857885629;5664.85837854057;98539;123422;125213.37393313157;126880.36559817143;128027;67370.3262967364;69989.65005174941;71246;86171.5691421539;113737;97255.99999999859;99349.50325248328;100035;101758.49120754497;102642.48678756559;10005.749281339833;10006.149477294512;10136.341137826017;10156.289059765746;10235.283530152818;57697.711511442176;58122.70938645449;58440.4155958435;58747.70626146842;59090;83951;86105;87161.56419217863;87861;90133;13338.599842004756;13502.122362046435;13611.86388136106;13811.033227673966;14106.083104598169;14959.850401495845;15350.385984560493;15439.305231264396;15971.920140399223;16328.428505002268;14422.278886055445;14480.927595361956;14609.853901461274;14706.852931470548;15576.688466230838;14058;14216.289185540889;14706.63233419173;14714;14751.483698070946;14263;14479.05886117399;14727.631809204855;14852.62868428298;14889.627759306104;10985.725356866142;11222.494987725735;11548.249363791327;11554.133439992202;11613.245139065933;12064.576032587702;12247.69380765488;12386.938065309616;12405.813912791496;12565.18326308787 02:48:03 INFO - PROCESS | 13233 | __end_tp_report 02:48:03 INFO - PROCESS | 13233 | __start_cc_report 02:48:03 INFO - PROCESS | 13233 | _x_x_mozilla_cycle_collect,877 02:48:03 INFO - PROCESS | 13233 | __end_cc_report 02:48:03 INFO - PROCESS | 13233 | __startTimestamp1465292883777__endTimestamp 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | ------- Summary: start ------- 02:48:03 INFO - PROCESS | 13233 | Number of tests: 6 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | [#0] dojo.html Cycles:165 Average:5713.57 Median:5924.85 stddev:645.31 (10.9%) stddev-sans-first:620.62 02:48:03 INFO - PROCESS | 13233 | Values: 3373.0 3414.5 3415.9 3432.3 3463.6 5700.7 5782.0 5798.2 5819.5 5842.2 5680.9 5702.1 5710.9 5711.4 5719.8 5140.0 5157.0 5160.2 5193.0 5198.6 5246.2 5268.3 5295.0 5299.5 5319.8 5194.1 5257.2 5261.4 5283.1 5306.1 5344.5 5354.0 5354.7 5356.4 5361.7 5017.3 5126.3 5175.3 5224.7 5231.6 5554.3 5584.2 5584.2 5638.2 5646.5 6163.5 6169.5 6176.7 6177.5 6178.6 6090.1 6155.9 6158.1 6202.1 6225.6 5793.6 5803.0 5836.5 5836.9 5840.4 6048.8 6357.7 6364.1 6365.5 6368.7 5962.3 6047.2 6059.6 6106.4 6109.2 6181.3 6189.9 6190.9 6194.2 6201.5 5778.6 5915.8 6059.4 6075.5 6075.8 6064.6 6115.9 6117.3 6132.4 6139.5 4620.9 4652.4 4654.9 4674.7 4678.7 4097.6 4108.9 4154.0 4158.7 4170.6 5894.1 5904.5 5905.6 5906.3 5930.6 6198.8 6229.6 6248.5 6249.5 6258.7 5703.9 5723.4 5815.2 5825.9 5887.6 5314.6 5320.2 5320.7 5324.3 5324.8 6434.2 6449.6 6453.3 6458.7 6463.4 6018.5 6030.2 6084.1 6121.6 6157.3 6331.3 6345.1 6345.8 6363.8 6386.5 6009.1 6062.8 6063.2 6066.7 6073.9 6016.4 6059.1 6111.4 6133.2 6151.1 5985.6 5985.7 5986.5 6020.1 6036.8 5759.0 5924.9 5995.6 6000.2 6002.7 5826.9 5895.3 5900.3 5964.5 5970.6 6125.6 6128.1 6131.3 6132.1 6134.9 5756.9 5887.8 5995.7 5996.6 6016.5 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | [#1] ext.html Cycles:180 Average:67050.54 Median:40852.79 stddev:141431.67 (346.2%) stddev-sans-first:141740.43 02:48:03 INFO - PROCESS | 13233 | Values: 602.2 654.3 656.3 661.1 666.7 33197.0 35833.1 35884.6 35900.1 35982.1 37035.3 37663.2 37788.0 48721.8 49402.0 9142.5 9342.0 9342.5 9343.4 9346.8 9141.3 9323.0 9325.9 9328.1 9339.0 8603.3 8850.1 8856.1 9085.3 11033.2 10878.6 11258.0 11278.7 11310.8 11317.1 11095.9 11175.1 11189.6 11193.4 11197.7 34906.0 44973.1 45653.0 46666.0 46685.5 3960.8 4096.6 4452.7 4554.5 4622.3 35835.3 35924.6 36001.0 36055.5 36115.6 4307.7 4342.0 4355.0 4362.8 4416.6 396717.0 399147.0 399988.0 400351.0 400409.0 39388.8 40826.4 40879.2 42727.4 70700.3 42982.6 42992.4 43028.1 43149.0 43218.4 17208.2 17262.8 17355.0 17375.0 17377.0 14065.9 14105.6 14111.3 14116.5 14234.2 9489.7 9593.8 9660.4 9711.3 9738.7 3416.9 3582.2 3687.9 3705.9 3747.0 1052.3 1052.8 1094.4 1143.7 1161.2 33811.5 34344.5 34898.3 34993.3 35338.0 1174.8 1181.0 1234.3 1249.9 1253.9 16572.3 17128.1 17242.9 17284.8 17351.4 628705.0 634981.0 635537.0 635846.0 637346.0 56950.0 57925.1 63170.7 63687.0 63890.7 1401.6 1434.3 1438.7 1438.8 1441.0 33787.0 34175.3 34946.0 35090.5 35129.6 55078.2 55714.7 55721.4 55736.7 55821.4 455315.0 459553.0 567091.0 569264.0 588042.0 31495.8 31575.0 31612.8 31752.0 31947.0 51589.2 52888.5 53470.0 53748.2 54300.2 44166.6 44866.8 45939.5 48843.5 49654.8 44582.0 45381.5 45647.8 45797.0 46601.1 44923.6 45324.5 45872.0 46118.5 46231.5 38627.0 40001.0 40259.2 40962.8 41315.2 30402.4 30519.2 30567.2 30681.0 30928.1 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | [#2] jquery.html Cycles:180 Average:29110.73 Median:2067.08 stddev:80369.82 (3888.1%) stddev-sans-first:80566.43 02:48:03 INFO - PROCESS | 13233 | Values: 432.9 435.3 435.5 436.2 440.7 17532.6 18016.3 18933.0 18980.4 19002.6 18099.6 18476.3 18619.9 18667.6 18689.3 5505.6 5940.2 5941.0 5943.0 5944.3 5835.9 5838.0 5900.4 5900.5 5902.1 5681.1 5810.0 5837.1 5838.7 5849.6 5445.3 5756.5 5812.7 5815.9 5820.0 5457.1 5643.6 5678.0 5679.8 5680.9 14565.7 14802.5 14818.0 14821.9 16616.9 2295.4 2509.4 2580.5 2680.6 2789.9 10401.8 10481.3 10483.8 10884.0 10928.9 1988.9 2023.6 2040.9 2047.2 2064.7 62452.4 85519.6 85747.6 85963.1 86151.1 11430.0 11500.9 11501.9 11604.0 11820.8 16341.3 16395.5 16491.1 16507.3 16517.5 7881.4 8106.3 8142.7 8152.3 8184.5 8136.7 8176.8 8184.5 8211.8 8227.8 4773.0 4797.2 4851.5 4946.7 5005.2 2069.5 2076.7 2077.3 2102.1 2135.7 920.9 941.3 977.7 999.1 1091.9 18000.4 18101.0 18269.3 19014.3 19284.7 988.4 1021.7 1027.5 1045.8 1077.8 8092.6 10077.6 10582.9 10647.2 10836.9 412266.0 413091.0 413670.0 569672.0 580863.0 103387.5 103745.0 106821.0 107095.0 109312.0 1058.3 1066.0 1084.7 1093.0 1105.8 17166.2 17398.7 17479.7 17577.1 17834.5 37715.4 42497.6 43842.0 44150.6 44465.1 54798.5 61693.7 63028.4 63385.2 63576.7 7922.1 8220.8 8295.2 8791.1 9163.1 10516.0 13105.5 13634.7 13688.4 14212.0 12303.3 12453.7 12458.4 12514.5 12583.0 11709.7 12197.3 12446.9 12527.8 12560.6 12456.1 12518.3 12735.9 12797.9 13054.5 9062.1 9393.6 9476.1 12431.5 13249.9 11834.2 11973.5 12160.8 12356.0 12523.9 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | [#3] mootools.html Cycles:180 Average:6274.75 Median:468.36 stddev:3602.47 (769.2%) stddev-sans-first:3594.32 02:48:03 INFO - PROCESS | 13233 | Values: 1449.0 1551.5 1592.3 1797.6 1922.6 9032.1 9489.7 9535.7 9738.7 9750.7 9520.7 9564.3 9627.5 9638.7 9642.5 2117.6 2384.3 2476.6 2501.5 2504.3 2426.1 2450.3 2451.2 2451.9 2452.1 2440.5 2459.0 2469.5 2470.6 2471.2 2080.6 2324.5 2375.1 2421.6 2424.9 2422.1 2447.5 2451.5 2455.2 2459.6 9563.3 9627.2 9629.0 9633.3 9635.0 5398.5 5507.7 5510.1 5510.2 5515.8 3503.1 3510.9 3570.2 3584.4 3621.5 1114.4 1135.2 1142.1 1166.4 1175.4 12663.1 12670.6 12691.9 12697.2 12711.6 4861.0 4907.7 4979.9 4986.2 4986.6 10477.5 10491.1 10578.2 10600.3 10616.6 5574.6 5577.6 5580.6 5586.3 5637.2 4572.9 5180.1 5353.8 5368.4 5436.5 4335.4 4374.1 4425.8 4455.2 4478.2 1343.7 1354.6 1359.9 1360.3 1378.3 909.2 985.6 1046.2 1054.1 1064.9 6295.7 6324.7 6409.9 6496.4 6504.4 462.2 467.7 469.1 470.9 500.1 4230.3 4382.0 4427.6 4432.0 4432.7 10826.5 11918.6 12322.9 12408.1 12449.5 11401.8 11416.2 11563.9 11692.8 11832.7 8797.3 9064.1 9075.3 9078.5 9084.8 6492.2 6693.3 6763.7 6914.4 6929.1 10897.6 10976.8 11061.6 11085.2 11170.8 11193.2 11270.9 11370.5 11394.6 11408.7 7564.1 7755.9 8549.2 8642.9 8649.7 9570.3 9604.6 9635.4 9683.7 9694.8 8379.7 8462.6 8627.3 8671.0 8841.7 8435.0 8533.5 8572.4 8617.6 8705.4 7760.2 7844.5 7860.5 7868.8 7874.8 5662.7 5666.5 5774.7 5808.1 5983.5 5791.8 5837.9 5871.9 5879.9 5902.6 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | [#4] prototype.html Cycles:180 Average:4915.41 Median:5582.78 stddev:1449.39 (26.0%) stddev-sans-first:1412.38 02:48:03 INFO - PROCESS | 13233 | Values: 350.3 357.0 357.7 359.7 363.7 5573.2 5633.5 5641.2 5671.9 5684.3 5569.1 5573.9 5591.6 5592.8 5594.7 4188.2 4341.2 4355.5 4386.5 4404.4 4356.5 4366.3 4367.9 4391.5 4402.9 4331.3 4359.8 4385.9 4391.3 4405.4 4117.9 4318.7 4340.5 4344.2 4371.1 3766.5 3800.8 3806.4 3819.1 3826.3 5370.5 5415.2 5444.8 5450.4 5533.1 4839.4 4963.8 4982.6 4994.5 5012.7 5801.5 5808.2 5810.9 5816.8 5845.0 4217.7 4244.9 4255.4 4257.1 4278.7 5654.4 5821.8 5922.6 6026.8 6129.5 4299.0 4301.0 4303.0 4320.6 4331.5 4298.1 4316.3 4318.0 4357.9 4361.9 4770.1 4844.7 4942.8 4962.5 4980.5 5832.7 5847.7 5866.8 5887.9 5889.2 1491.7 1510.4 1512.6 1515.2 1515.2 943.6 957.7 960.2 964.6 964.7 4923.9 5068.0 5075.5 5118.8 5136.0 5302.2 5303.9 5399.3 5416.9 5424.7 5169.8 5197.5 5396.8 5807.6 5848.9 3165.6 3205.5 3206.6 3226.3 3232.0 6106.9 6233.5 6244.6 6256.2 6311.5 6174.1 6183.6 6185.2 6188.6 6202.8 6211.2 6273.0 6324.9 6352.6 6385.6 5868.3 6116.6 6155.5 6188.6 6190.6 5793.2 6079.8 6089.9 6104.8 6107.4 6082.5 6238.2 6247.7 6257.4 6258.9 4286.8 4340.6 4343.9 4348.5 4355.1 5799.2 6098.5 6119.8 6128.1 6146.7 5820.0 5874.5 5943.0 5954.8 5969.7 5679.3 5900.3 5926.4 5934.7 5934.9 5751.2 5783.9 5785.5 5804.5 5808.6 5912.9 5913.3 5942.3 5977.0 5991.5 5704.7 5788.8 5823.7 5835.0 5878.9 02:48:03 INFO - PROCESS | 13233 | 02:48:03 INFO - PROCESS | 13233 | [#5] yui.html Cycles:180 Average:21971.01 Median:3981.22 stddev:31169.48 (782.9%) stddev-sans-first:31216.44 02:48:03 INFO - PROCESS | 13233 | Values: 815.6 824.3 832.0 853.7 900.5 15489.1 17924.2 17929.3 17939.2 17979.7 16166.4 16183.5 16221.0 16241.4 16620.4 755.6 875.0 895.6 896.6 906.1 894.2 902.5 903.1 903.1 903.7 791.4 926.1 942.3 945.4 960.6 940.2 941.5 941.6 941.7 943.3 690.8 691.3 691.3 691.5 691.5 16657.3 16699.8 16703.5 16709.3 16727.7 14401.3 14498.9 14582.9 14650.1 14705.9 13722.5 13817.0 13976.4 13985.2 13989.8 4691.6 4727.0 4730.6 4755.9 4841.8 75574.6 75841.0 77098.8 77400.0 77674.2 12033.6 12118.9 12173.3 12232.8 12352.0 21761.7 21770.5 21814.8 21832.5 21918.9 8750.2 8768.4 8798.7 8949.1 9015.3 5121.2 5128.4 5216.6 5245.4 5290.9 3458.4 3832.1 3971.2 3991.3 4108.8 732.3 735.8 736.4 745.7 749.7 661.7 728.0 769.4 788.9 791.8 10768.4 10827.2 10975.5 11012.4 11156.7 665.2 681.1 729.2 812.2 822.2 5365.8 5385.3 5604.4 5610.4 5664.9 98539.0 123422.0 125213.4 126880.4 128027.0 67370.3 69989.7 71246.0 86171.6 113737.0 97256.0 99349.5 100035.0 101758.5 102642.5 10005.7 10006.1 10136.3 10156.3 10235.3 57697.7 58122.7 58440.4 58747.7 59090.0 83951.0 86105.0 87161.6 87861.0 90133.0 13338.6 13502.1 13611.9 13811.0 14106.1 14959.9 15350.4 15439.3 15971.9 16328.4 14422.3 14480.9 14609.9 14706.9 15576.7 14058.0 14216.3 14706.6 14714.0 14751.5 14263.0 14479.1 14727.6 14852.6 14889.6 10985.7 11222.5 11548.2 11554.1 11613.2 12064.6 12247.7 12386.9 12405.8 12565.2 02:48:03 INFO - PROCESS | 13233 | -------- Summary: end -------- 02:48:03 INFO - PROCESS | 13233 | 02:48:04 INFO - TEST-INFO | 13233: exit 0 02:48:04 INFO - TEST-OK | dromaeo_css | took 1112825ms 02:48:04 INFO - TEST-START | kraken 02:48:04 INFO - operating with platform_type : linux_ 02:48:04 INFO - Initialising browser for kraken test... 02:48:04 INFO - TEST-INFO | started process 13423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeMTsPR/profile http://localhost:39978/getInfo.html) 02:48:08 INFO - PROCESS | 13423 | __metrics Screen width/height:1600/1200 02:48:08 INFO - PROCESS | 13423 | colorDepth:24 02:48:08 INFO - PROCESS | 13423 | Browser inner width/height: 1024/697 02:48:08 INFO - PROCESS | 13423 | __metrics 02:48:09 ERROR - PROCESS | 13423 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:48:09 INFO - PROCESS | 13423 | console.error: PushService: 02:48:09 INFO - PROCESS | 13423 | stateChangeProcessEnqueue: Error transitioning state 02:48:09 INFO - PROCESS | 13423 | UnknownError 02:48:10 INFO - TEST-INFO | 13423: exit 0 02:48:10 INFO - Browser initialized. 02:48:10 INFO - Running cycle 1/1 for kraken test... 02:48:10 INFO - TEST-INFO | started process 13511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeMTsPR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:22 INFO - PROCESS | 13511 | RSS: Main: 145616896 02:48:22 INFO - PROCESS | 13511 | 02:48:24 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39978/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:25 INFO - PROCESS | 13511 | RSS: Main: 195035136 02:48:25 INFO - PROCESS | 13511 | 02:48:28 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39978/tests/kraken/driver.html?testName=audio-dft) 02:48:28 INFO - PROCESS | 13511 | RSS: Main: 193392640 02:48:28 INFO - PROCESS | 13511 | 02:48:31 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39978/tests/kraken/driver.html?testName=audio-fft) 02:48:32 INFO - PROCESS | 13511 | RSS: Main: 279207936 02:48:32 INFO - PROCESS | 13511 | 02:48:34 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39978/tests/kraken/driver.html?testName=audio-oscillator) 02:48:34 INFO - PROCESS | 13511 | RSS: Main: 187658240 02:48:34 INFO - PROCESS | 13511 | 02:48:37 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:48:37 INFO - PROCESS | 13511 | RSS: Main: 188899328 02:48:37 INFO - PROCESS | 13511 | 02:48:40 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39978/tests/kraken/driver.html?testName=imaging-darkroom) 02:48:41 INFO - PROCESS | 13511 | RSS: Main: 223027200 02:48:41 INFO - PROCESS | 13511 | 02:48:44 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39978/tests/kraken/driver.html?testName=imaging-desaturate) 02:48:45 INFO - PROCESS | 13511 | RSS: Main: 224264192 02:48:45 INFO - PROCESS | 13511 | 02:48:48 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39978/tests/kraken/driver.html?testName=json-parse-financial) 02:48:48 INFO - PROCESS | 13511 | RSS: Main: 223907840 02:48:48 INFO - PROCESS | 13511 | 02:48:50 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:48:50 INFO - PROCESS | 13511 | RSS: Main: 200003584 02:48:50 INFO - PROCESS | 13511 | 02:48:52 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:48:53 INFO - PROCESS | 13511 | RSS: Main: 202620928 02:48:53 INFO - PROCESS | 13511 | 02:48:55 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:48:55 INFO - PROCESS | 13511 | RSS: Main: 207818752 02:48:55 INFO - PROCESS | 13511 | 02:48:58 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:58 INFO - PROCESS | 13511 | RSS: Main: 217272320 02:48:58 INFO - PROCESS | 13511 | 02:49:01 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:49:02 INFO - PROCESS | 13511 | RSS: Main: 216727552 02:49:02 INFO - PROCESS | 13511 | 02:49:03 INFO - PROCESS | 13511 | Cycle 1(1): loaded http://localhost:39978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39978/tests/kraken/driver.html?testName=ai-astar) 02:49:04 INFO - PROCESS | 13511 | RSS: Main: 258740224 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | __start_tp_report 02:49:04 INFO - PROCESS | 13511 | _x_x_mozilla_page_load 02:49:04 INFO - PROCESS | 13511 | _x_x_mozilla_page_load_details 02:49:04 INFO - PROCESS | 13511 | |i|pagename|runs| 02:49:04 INFO - PROCESS | 13511 | |0;ai-astar;111;104;109;110;109;110;108;109;109;109 02:49:04 INFO - PROCESS | 13511 | |1;audio-beat-detection;155;123;124;180;125;124;159;122;157;129 02:49:04 INFO - PROCESS | 13511 | |2;audio-dft;161;161;161;163;160;162;162;162;161;160 02:49:04 INFO - PROCESS | 13511 | |3;audio-fft;74;77;76;142;75;75;75;75;98;74 02:49:04 INFO - PROCESS | 13511 | |4;audio-oscillator;85;84;119;85;86;84;119;85;84;118 02:49:04 INFO - PROCESS | 13511 | |5;imaging-gaussian-blur;117;116;116;117;116;116;117;117;117;116 02:49:04 INFO - PROCESS | 13511 | |6;imaging-darkroom;145;145;146;146;146;145;145;145;145;146 02:49:04 INFO - PROCESS | 13511 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;94;94 02:49:04 INFO - PROCESS | 13511 | |8;json-parse-financial;50;51;51;50;51;52;51;53;51;53 02:49:04 INFO - PROCESS | 13511 | |9;json-stringify-tinderbox;60;59;59;59;59;60;60;60;59;60 02:49:04 INFO - PROCESS | 13511 | |10;stanford-crypto-aes;77;77;76;76;75;77;77;77;107;76 02:49:04 INFO - PROCESS | 13511 | |11;stanford-crypto-ccm;116;114;126;113;123;113;136;130;139;133 02:49:04 INFO - PROCESS | 13511 | |12;stanford-crypto-pbkdf2;155;157;154;154;155;155;160;153;151;157 02:49:04 INFO - PROCESS | 13511 | |13;stanford-crypto-sha256-iterative;61;61;61;61;62;64;61;62;60;59 02:49:04 INFO - PROCESS | 13511 | __end_tp_report 02:49:04 INFO - PROCESS | 13511 | __start_cc_report 02:49:04 INFO - PROCESS | 13511 | _x_x_mozilla_cycle_collect,1582 02:49:04 INFO - PROCESS | 13511 | __end_cc_report 02:49:04 INFO - PROCESS | 13511 | __startTimestamp1465292944004__endTimestamp 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | ------- Summary: start ------- 02:49:04 INFO - PROCESS | 13511 | Number of tests: 14 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:1.87 (1.7%) stddev-sans-first:1.81 02:49:04 INFO - PROCESS | 13511 | Values: 111.0 104.0 109.0 110.0 109.0 110.0 108.0 109.0 109.0 109.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:142.00 stddev:20.94 (14.7%) stddev-sans-first:21.47 02:49:04 INFO - PROCESS | 13511 | Values: 155.0 123.0 124.0 180.0 125.0 124.0 159.0 122.0 157.0 129.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 02:49:04 INFO - PROCESS | 13511 | Values: 161.0 161.0 161.0 163.0 160.0 162.0 162.0 162.0 161.0 160.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#3] audio-fft Cycles:10 Average:84.10 Median:75.00 stddev:21.59 (28.8%) stddev-sans-first:22.59 02:49:04 INFO - PROCESS | 13511 | Values: 74.0 77.0 76.0 142.0 75.0 75.0 75.0 75.0 98.0 74.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.50 stddev:16.41 (19.4%) stddev-sans-first:17.01 02:49:04 INFO - PROCESS | 13511 | Values: 85.0 84.0 119.0 85.0 86.0 84.0 119.0 85.0 84.0 118.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:49:04 INFO - PROCESS | 13511 | Values: 117.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:49:04 INFO - PROCESS | 13511 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:49:04 INFO - PROCESS | 13511 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:1.06 (2.1%) stddev-sans-first:1.01 02:49:04 INFO - PROCESS | 13511 | Values: 50.0 51.0 51.0 50.0 51.0 52.0 51.0 53.0 51.0 53.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 02:49:04 INFO - PROCESS | 13511 | Values: 60.0 59.0 59.0 59.0 59.0 60.0 60.0 60.0 59.0 60.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:77.00 stddev:9.69 (12.6%) stddev-sans-first:10.23 02:49:04 INFO - PROCESS | 13511 | Values: 77.0 77.0 76.0 76.0 75.0 77.0 77.0 77.0 107.0 76.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:128.00 stddev:9.98 (7.8%) stddev-sans-first:10.12 02:49:04 INFO - PROCESS | 13511 | Values: 116.0 114.0 126.0 113.0 123.0 113.0 136.0 130.0 139.0 133.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.00 stddev:2.47 (1.6%) stddev-sans-first:2.62 02:49:04 INFO - PROCESS | 13511 | Values: 155.0 157.0 154.0 154.0 155.0 155.0 160.0 153.0 151.0 157.0 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - PROCESS | 13511 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:1.32 (2.2%) stddev-sans-first:1.39 02:49:04 INFO - PROCESS | 13511 | Values: 61.0 61.0 61.0 61.0 62.0 64.0 61.0 62.0 60.0 59.0 02:49:04 INFO - PROCESS | 13511 | -------- Summary: end -------- 02:49:04 INFO - PROCESS | 13511 | 02:49:04 INFO - TEST-INFO | 13511: exit 0 02:49:04 INFO - TEST-OK | kraken | took 60341ms 02:49:04 INFO - SUITE-END | took 1173s 02:49:05 INFO - Completed test suite (00:19:33) 02:49:05 INFO - javascript benchmark 02:49:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3373.021823671135, 3414.470757032659, 3415.9487607685874, 3432.2792213635134, 3463.5843698756153, 5700.686462244575, 5782.045962416201, 5798.217240672508, 5819.476247137757, 5842.152887831262, 5680.886382272352, 5702.087665973445, 5710.942890571093, 5711.371749107605, 5719.828405147842, 5140.0490909181735, 5157.020166168425, 5160.225966105096, 5193.0, 5198.636095473318, 5246.1868410396255, 5268.262443257928, 5295.0468915595175, 5299.49654782795, 5319.840404787863, 5194.065068287707, 5257.158854583267, 5261.421243663194, 5283.07546179419, 5306.071437498442, 5344.518993290603, 5353.973230133864, 5354.705491198021, 5356.35723713153, 5361.731913404315, 5017.347744793154, 5126.256692779526, 5175.327207463006, 5224.686518808883, 5231.633785635007, 5554.333479982428, 5584.21820945068, 5584.246126772915, 5638.182463542763, 5646.463585959327, 6163.537734669918, 6169.537284703621, 6176.722047507873, 6177.536684748662, 6178.567500274982, 6090.086487026937, 6155.876882462326, 6158.076288556707, 6202.100695399187, 6225.564210505267, 5793.565482588822, 5802.97098514509, 5836.503897168745, 5836.854078648025, 5840.386759390203, 6048.788292409745, 6357.650329231937, 6364.077208804697, 6365.458935990493, 6368.713407896563, 5962.314333851663, 6047.213862197974, 6059.6364218147055, 6106.389361063858, 6109.236345456818, 6181.258249010148, 6189.876202475925, 6190.938090619126, 6194.194754681863, 6201.503879689614, 5778.624389414758, 5915.792947246826, 6059.424354686298, 6075.453209211104, 6075.756969721162, 6064.605800622945, 6115.879294474695, 6117.309816958451, 6132.4166970161305, 6139.522803442322, 4620.861374158713, 4652.418447694038, 4654.930176047362, 4674.696144750648, 4678.719276843332, 4097.610726980932, 4108.876733697994, 4154.044569748975, 4158.7296825706835, 4170.562090980464, 5894.145348924468, 5904.4685978261305, 5905.586608937333, 5906.3207731110615, 5930.614510056833, 6198.845028874224, 6229.626222426669, 6248.5313601479165, 6249.500039996789, 6258.655773932386, 5703.8859222816145, 5723.399043100498, 5815.214945982323, 5825.854353641193, 5887.646741195542, 5314.601404894571, 5320.1753728171425, 5320.654157479751, 5324.334458192726, 5324.787008519694, 6434.163558737334, 6449.580777249464, 6453.290138084807, 6458.709358078898, 6463.385978332051, 6018.488428483628, 6030.246219222598, 6084.056971169476, 6121.571489995657, 6157.26112866441, 6331.303556608861, 6345.079963405188, 6345.809625711236, 6363.809085727436, 6386.457151142019, 6009.06859436788, 6062.848428789315, 6063.181470501426, 6066.696665166813, 6073.939260607514, 6016.398360164124, 6059.0608455689435, 6111.419415155553, 6133.233345831771, 6151.141477252921, 5985.610935289193, 5985.700714964321, 5986.461218490357, 6020.096985452217, 6036.849078773066, 5759.04975679025, 5924.851878702894, 5995.640261584319, 6000.159977603226, 6002.669853158118, 5826.854328641818, 5895.29256489224, 5900.321463031806, 5964.463198312173, 5970.58205925581, 6125.607917153528, 6128.111423843607, 6131.277598982041, 6132.08018797184, 6134.9079763804475, 5756.94243057564, 5887.8233652990475, 5995.670238136944, 5996.610220335664, 6016.458518733335], "value": 5670.672097804014, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.1569802276812, 654.3195077119794, 656.3010393930464, 661.1438187547129, 666.726642076748, 33197.0, 35833.1041723957, 35884.641153588454, 35900.10249743755, 35982.100447488796, 37035.25929481409, 37663.24673506528, 37788.0, 48721.756391218085, 49402.0, 9142.542872856347, 9341.95329023354, 9342.532873356338, 9343.392679475812, 9346.81306373872, 9141.31440141992, 9323.0, 9325.86011209829, 9328.06719328065, 9339.0, 8603.268722158624, 8850.070742572034, 8856.070112638177, 9085.318601104911, 11033.172512061587, 10878.564857405694, 11258.04306633937, 11278.661640150767, 11310.773784524263, 11317.094632429385, 11095.944520277428, 11175.050120739746, 11189.552417903275, 11193.384363859985, 11197.66407007791, 34906.0, 44973.10053798938, 45653.0, 46666.0, 46685.53314466846, 3960.782156981365, 4096.631303182728, 4452.732836029816, 4554.453465584151, 4622.260438329885, 35835.28329433397, 35924.64075359239, 36001.0, 36055.4591681125, 36115.638843611494, 4307.655387568987, 4342.0, 4355.0, 4362.760048197348, 4416.6025057744955, 396717.0, 399147.0, 399988.0, 400351.0, 400409.0, 39388.803055984536, 40826.38760418596, 40879.182416351505, 42727.35908961368, 70700.2929970704, 42982.57017429848, 42992.35511467331, 43028.13943721108, 43149.0, 43218.351724724154, 17208.225629846685, 17262.827371726373, 17355.0, 17375.04437255963, 17377.0, 14065.929670351583, 14105.647358815906, 14111.294435278194, 14116.50592229267, 14234.217118058607, 9489.718887950177, 9593.808123837483, 9660.420374777535, 9711.27165462579, 9738.707838764849, 3416.8974930752115, 3582.17609949713, 3687.90780230491, 3705.9258814824093, 3746.981265093657, 1052.2634156090614, 1052.7789164275434, 1094.43089593411, 1143.6912033751007, 1161.2103769436865, 33811.4928276076, 34344.48483272753, 34898.30203395918, 34993.30013399768, 35338.0, 1174.7591743692522, 1181.0374544746005, 1234.3334599316447, 1249.900007999358, 1253.9122261441612, 16572.254248558846, 17128.14359282031, 17242.913785431243, 17284.827151728572, 17351.43837054671, 628705.0, 634981.0, 635537.0, 635846.0, 637346.0, 56950.0, 57925.131123033185, 63170.68414657989, 63687.0, 63890.68054659697, 1401.6495876030992, 1434.3402035063987, 1438.697873446567, 1438.7841823726524, 1440.9783853242209, 33787.0, 34175.316493670485, 34946.0, 35090.473642895886, 35129.64870351264, 55078.173827391816, 55714.72142639261, 55721.44278557163, 55736.72131639316, 55821.44178558325, 455315.0, 459553.0, 567091.0, 569264.0, 588042.0, 31495.84252078725, 31575.0, 31612.841935790173, 31752.0, 31947.0, 51589.22616160686, 52888.471115288354, 53470.0, 53748.19377709416, 54300.185497218365, 44166.55833441753, 44866.77566612146, 45939.54060459352, 48843.5115648839, 49654.75172624258, 44582.0, 45381.54618453773, 45647.77176114231, 45797.0, 46601.06797864092, 44923.550764491934, 45324.54675453335, 45872.0, 46118.538814612766, 46231.53768462272, 38627.0, 40001.0, 40259.1948161041, 40962.79518602388, 41315.1736965265, 30402.39195216039, 30519.237019074702, 30567.2358191047, 30681.0, 30928.0721578353], "value": 20547.227960580487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.9415528903598, 435.301341347138, 435.5254451544092, 436.1647445142551, 440.66729619137544, 17532.56168595784, 18016.279348826032, 18933.0, 18980.430587082374, 19002.61994760104, 18099.63800723988, 18476.260949562035, 18619.906900465514, 18667.626647467077, 18689.252429902786, 5505.587080968933, 5940.19807326012, 5941.0494320908665, 5943.049112142058, 5944.256967879015, 5835.912461313083, 5837.970810145944, 5900.380460051697, 5900.498457631085, 5902.144189092601, 5681.091025435931, 5809.970950145264, 5837.066069428893, 5838.737256823453, 5849.64902105875, 5445.292112025411, 5756.481916627482, 5812.680302583356, 5815.912761308584, 5820.039693450575, 5457.099578569571, 5643.633163844337, 5678.0, 5679.807240479504, 5680.857978550528, 14565.708685826225, 14802.481913132988, 14818.0, 14821.851781482155, 16616.916915415466, 2295.3802473332275, 2509.4353770401513, 2580.522603318392, 2680.5711086226306, 2789.8744556495008, 10401.79196416075, 10481.266311358208, 10483.842742358871, 10884.0, 10928.890711092867, 1988.8906110163934, 2023.5750492396614, 2040.8571400002006, 2047.1504325704814, 2064.669652855551, 62452.383199153664, 85519.57240213822, 85747.57126214329, 85963.14036859614, 86151.13848861493, 11430.028447582048, 11500.88499115015, 11501.884981150082, 11604.0, 11820.76358472843, 16341.264643090852, 16395.508134755975, 16491.09298988543, 16507.257173427224, 16517.504474865775, 7881.408894332948, 8106.270435660819, 8142.674293028331, 8152.307053900485, 8184.54984975832, 8136.7152149674475, 8176.83646327082, 8184.549849758201, 8211.7947051323, 8227.794305142299, 4773.0, 4797.18447863864, 4851.490593487703, 4946.653734238641, 5005.249212618136, 2069.4826293426645, 2076.688496725473, 2077.2729544659246, 2102.117110813462, 2135.6689713094497, 920.8664743612272, 941.261110028638, 977.7066879935991, 999.0509016434416, 1091.9344839309667, 18000.369987050653, 18101.0, 18269.269229230682, 19014.334498292494, 19284.710729339073, 988.4464699768153, 1021.7088129882948, 1027.4862568715641, 1045.7803861189084, 1077.8167711489066, 8092.635831387602, 10077.59689612422, 10582.894171058344, 10647.23344684831, 10836.891631083747, 412266.0, 413091.0, 413670.0, 569672.0, 580863.0, 103387.48306258571, 103745.0, 106821.0, 107095.0, 109312.0, 1058.2962330050584, 1065.9626913058005, 1084.7450849050624, 1092.9890701093045, 1105.834124881258, 17166.22751976189, 17398.73901891498, 17479.737803933207, 17577.121143942495, 17834.46496605104, 37715.43426848545, 42497.5750242506, 43842.0, 44150.55849441465, 44465.11069778651, 54798.45201548093, 61693.69153154385, 63028.36971630225, 63385.19688818686, 63576.68211658912, 7922.128565857866, 8220.83558328842, 8295.170482951657, 8791.076936921787, 9163.129502697233, 10516.0, 13105.475780969036, 13634.727305453636, 13688.384022718803, 14212.0, 12303.323317217639, 12453.688657783629, 12458.439370228543, 12514.499420023098, 12583.0, 11709.707257318636, 12197.268163910194, 12446.875531244572, 12527.812082818948, 12560.560380387009, 12456.12807103494, 12518.311492867979, 12735.936320318338, 12797.936010319889, 13054.477820887058, 9062.093790620886, 9393.577289022147, 9476.099770521789, 12431.502739890304, 13249.867501324863, 11834.171607987359, 11973.461194246454, 12160.817587736014, 12356.0, 12523.874761252271], "value": 9412.032034353406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.0, 1551.4880089570443, 1592.2755146408383, 1797.5955410032736, 1922.5578117033083, 9032.051634578373, 9489.667861624845, 9535.666251681192, 9738.659146929858, 9750.70747877563, 9520.666776662818, 9564.330496865205, 9627.470489123096, 9638.710838674851, 9642.517874106285, 2117.5553133841913, 2384.2966324934187, 2476.5913624251975, 2501.4746903150362, 2504.3488692939786, 2426.1265944260053, 2450.3384086296687, 2451.166603354859, 2451.8774061296954, 2452.080469823816, 2440.487497625492, 2458.9754102458924, 2469.4814089041324, 2470.5923522618746, 2471.2462698876834, 2080.6358887194756, 2324.5118525109747, 2375.085592047066, 2421.6367544868235, 2424.866632335221, 2422.1280339077916, 2447.4615584571366, 2451.497443024176, 2455.177515532299, 2459.631055341695, 9563.282753793494, 9627.229821614254, 9629.0, 9633.277504187145, 9635.0, 5398.514133727944, 5507.7246137693355, 5510.118381059011, 5510.201020851994, 5515.806946756885, 3503.1067077895227, 3510.929781404383, 3570.1788588624504, 3584.390653588896, 3621.4567814827724, 1114.3703807348902, 1135.233717240859, 1142.0692135909208, 1166.381817636654, 1175.3887978251262, 12663.113582049353, 12670.619881403572, 12691.873081269161, 12697.174683645533, 12711.61865144038, 4861.0, 4907.68100073494, 4979.90040199194, 4986.227134794112, 4986.626003049713, 10477.47612619366, 10491.055804977588, 10578.153747700166, 10600.257981941344, 10616.575336986589, 5574.581906356958, 5577.553795696334, 5580.553555715533, 5586.329640443173, 5637.23897273871, 4572.885677858014, 5180.145276029489, 5353.785848566092, 5368.436314187033, 5436.53789427903, 4335.393044973706, 4374.125174964956, 4425.845095421645, 4455.220336441174, 4478.171538265431, 1343.6640839790052, 1354.634248752851, 1359.8708122728524, 1360.2926478231263, 1378.2970684950747, 909.2089881802874, 985.6156099121348, 1046.1892033673964, 1054.0513537816028, 1064.8775390829999, 6295.653739044396, 6324.683765811691, 6409.935900640934, 6496.415322620986, 6504.382083702136, 462.1819379697916, 467.6679557514135, 469.0571950379761, 470.9481956984729, 500.07236576150717, 4230.280852255124, 4381.978090109529, 4427.601515863524, 4432.002799370116, 4432.667549933703, 10826.512806923707, 11918.642440726791, 12322.876771232173, 12408.069394795426, 12449.502019919102, 11401.828972565418, 11416.20086593947, 11563.88436115628, 11692.824607630891, 11832.704182395337, 8797.29621630268, 9064.138906803842, 9075.273978081737, 9078.54607269634, 9084.818973533398, 6492.156019717407, 6693.330666933268, 6763.695633696397, 6914.377706006484, 6929.133858267716, 10897.618583349862, 10976.835347469954, 11061.612843550438, 11085.168612353944, 11170.832437513282, 11193.160512961398, 11270.887291126985, 11370.488328025092, 11394.601188958679, 11408.714782130513, 7564.130125035691, 7755.883661745192, 8549.187827156658, 8642.870356944777, 8649.697260595849, 9570.330076894828, 9604.615815367308, 9635.421874687541, 9683.66107186245, 9694.75763105928, 8379.664813407395, 8462.576871156294, 8627.309815214894, 8671.0, 8841.69054083104, 8435.0, 8533.53065581399, 8572.3999320047, 8617.612207450555, 8705.434146780439, 7760.18518055596, 7844.450888437755, 7860.528368297921, 7868.803279918048, 7874.803129921798, 5662.688552129673, 5666.46168613981, 5774.700692344189, 5808.07070868659, 5983.521318294439, 5791.797287094932, 5837.883242335214, 5871.882562348815, 5879.853003674943, 5902.61632993854], "value": 4896.5464766778005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3133857639027, 357.027101149368, 357.72276485723563, 359.7212160575552, 363.6817784438616, 5573.247611572437, 5633.521150702195, 5641.2384328115695, 5671.914921276179, 5684.294711586528, 5569.136783798518, 5573.916391254134, 5591.6365436246715, 5592.8255066435995, 5594.720263986795, 4188.162367526499, 4341.153475072362, 4355.455568053993, 4386.473623165225, 4404.4494438195225, 4356.455443069616, 4366.323219900921, 4367.908022994251, 4391.473023237216, 4402.889927751799, 4331.285337919256, 4359.847405340814, 4385.890352741175, 4391.341298805189, 4405.383246345515, 4117.938230926524, 4318.740875547477, 4340.52254252032, 4344.218040752663, 4371.060222052258, 3766.5291838520184, 3800.771953682788, 3806.410006449005, 3819.1216020315205, 3826.253880493305, 5370.489803468664, 5415.241866138744, 5444.836654900319, 5450.427705090988, 5533.114701647757, 4839.419269687624, 4963.80868591539, 4982.60139188864, 4994.500549945013, 5012.699238045729, 5801.477866991991, 5808.157817116495, 5810.854728631776, 5816.789619944394, 5845.0, 4217.650351887397, 4244.9151016979795, 4255.404243405895, 4257.1485702859245, 4278.721883077621, 5654.434556544354, 5821.767129314865, 5922.615030023077, 6026.8493287667725, 6129.509639228851, 4299.0, 4300.978495107567, 4302.9569704303185, 4320.589543993316, 4331.480222373272, 4298.118885628439, 4316.330968699856, 4317.978410107992, 4357.888738371695, 4361.890952726144, 4770.141374552544, 4844.709317440965, 4942.827001055018, 4962.528559786814, 4980.501949805063, 5832.650040997553, 5847.678377689268, 5866.794662186803, 5887.911681324784, 5889.234399528034, 1491.6942026884462, 1510.4335874047233, 1512.6445285357931, 1515.181801827023, 1515.1893736850732, 943.6272672294542, 957.6935380678116, 960.1550635440767, 964.609333220033, 964.7009427077628, 4923.926141107886, 5067.986402719471, 5075.492450754969, 5118.846434606968, 5135.97432012845, 5302.2311764793885, 5303.939212157584, 5399.271098401744, 5416.891662166813, 5424.728763561806, 5169.759257778106, 5197.480251974772, 5396.757145928443, 5807.593468457168, 5848.912266315923, 3165.572647692578, 3205.5191721241536, 3206.615206175274, 3226.2579606690592, 3232.0, 6106.877862442726, 6233.470155036873, 6244.625322480666, 6256.249250090018, 6311.495080393557, 6174.135621013062, 6183.57777711129, 6185.165002724664, 6188.628682279078, 6202.81391558254, 6211.173915868269, 6272.968635156795, 6324.936750632527, 6352.555321127476, 6385.584936979081, 5868.2664666916635, 6116.602420842631, 6155.507559395327, 6188.5864512839125, 6190.628562286277, 5793.217915581511, 6079.848003799763, 6089.908651370321, 6104.786332478342, 6107.358727333566, 6082.482988945989, 6238.189035425366, 6247.687615619292, 6257.374262573889, 6258.93455159787, 4286.764227967367, 4340.587644173798, 4343.913121737611, 4348.499922508826, 4355.107203023436, 5799.188113664006, 6098.5426093042315, 6119.755209791559, 6128.111423843607, 6146.692665366624, 5819.970900145472, 5874.471297583067, 5942.970285148546, 5954.779270249675, 5969.671668058299, 5679.290088738908, 5900.321463031806, 5926.407359264212, 5934.732937017759, 5934.910976335272, 5751.223584816164, 5783.913241301299, 5785.537157027512, 5804.506616937608, 5808.6224395414165, 5912.906112369225, 5913.349531551612, 5942.346341902474, 5977.0, 5991.490723288395, 5704.743286552198, 5788.797392091256, 5823.699638642628, 5834.970825145847, 5878.911816322673], "value": 4454.782401709495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.5759005317235, 824.3281725393804, 832.0223737108897, 853.7481442974324, 900.5227229568331, 15489.14809685467, 17924.193411296492, 17929.282828686853, 17939.192736326862, 17979.73030404545, 16166.353345866151, 16183.514494565152, 16221.0, 16241.431549895757, 16620.418285359985, 755.6221889055458, 874.9737507874773, 895.5880295064246, 896.5651658945407, 906.1074841281333, 894.217559635319, 902.5081330674765, 903.0517956146053, 903.1420150856679, 903.7062954539768, 791.4499422901087, 926.0785518409192, 942.2697409507618, 945.3760518058083, 960.6397600899662, 940.1773448232797, 941.5245301122958, 941.5857022909897, 941.6704153546273, 943.3349488610513, 690.8031211104861, 691.2810676896022, 691.3017851969497, 691.4848437913736, 691.5193940211554, 16657.33370665172, 16699.83300166995, 16703.498895033168, 16709.331626734915, 16727.665446690997, 14401.279936003262, 14498.855011449961, 14582.854171458255, 14650.120992740469, 14705.852941470663, 13722.45110195601, 13817.0, 13976.440942362293, 13985.230812305319, 13989.790153147711, 4691.577758001762, 4727.0, 4730.621550276004, 4755.904881902377, 4841.8063277468855, 75574.62212688901, 75841.0, 77098.84351734785, 77400.0, 77674.22325776727, 12033.578824741093, 12118.939405302917, 12173.2696038238, 12232.81650775239, 12352.0, 21761.673574896387, 21770.455738606663, 21814.781852181273, 21832.45418864541, 21918.89040554819, 8750.212480876624, 8768.430052046597, 8798.736037918872, 8949.149830766068, 9015.323850711224, 5121.155009423478, 5128.410232823198, 5216.58267338612, 5245.396779370345, 5290.947090529045, 3458.3774920514047, 3832.080300727805, 3971.1859068891386, 3991.261616600938, 4108.753474791522, 732.2860211294052, 735.797655644702, 736.3998341351781, 745.6868115391549, 749.6851322444586, 661.7022339947043, 727.9735572842267, 769.4498433619989, 788.8501184774874, 791.8218400859761, 10768.3538987661, 10827.24209305341, 10975.50610222542, 11012.39431831257, 11156.665300041012, 665.2084020016165, 681.0873429604255, 729.1687476277049, 812.2243257688893, 822.1860358245294, 5365.8390248291835, 5385.264693101913, 5604.41153678866, 5610.382857885629, 5664.85837854057, 98539.0, 123422.0, 125213.37393313157, 126880.36559817143, 128027.0, 67370.3262967364, 69989.65005174941, 71246.0, 86171.5691421539, 113737.0, 97255.99999999859, 99349.50325248328, 100035.0, 101758.49120754497, 102642.48678756559, 10005.749281339833, 10006.149477294512, 10136.341137826017, 10156.289059765746, 10235.283530152818, 57697.711511442176, 58122.70938645449, 58440.4155958435, 58747.70626146842, 59090.0, 83951.0, 86105.0, 87161.56419217863, 87861.0, 90133.0, 13338.599842004756, 13502.122362046435, 13611.86388136106, 13811.033227673966, 14106.083104598169, 14959.850401495845, 15350.385984560493, 15439.305231264396, 15971.920140399223, 16328.428505002268, 14422.278886055445, 14480.927595361956, 14609.853901461274, 14706.852931470548, 15576.688466230838, 14058.0, 14216.289185540889, 14706.63233419173, 14714.0, 14751.483698070946, 14263.0, 14479.05886117399, 14727.631809204855, 14852.62868428298, 14889.627759306104, 10985.725356866142, 11222.494987725735, 11548.249363791327, 11554.133439992202, 11613.245139065933, 12064.576032587702, 12247.69380765488, 12386.938065309616, 12405.813912791496, 12565.18326308787], "value": 8196.065458524057, "unit": "score"}], "name": "dromaeo_css", "value": 7622.059828023716, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 109.0, 110.0, 109.0, 110.0, 108.0, 109.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 124.0, 180.0, 125.0, 124.0, 159.0, 122.0, 157.0, 129.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 160.0, 162.0, 162.0, 162.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 142.0, 75.0, 75.0, 75.0, 75.0, 98.0, 74.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 119.0, 85.0, 86.0, 84.0, 119.0, 85.0, 84.0, 118.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 50.0, 51.0, 52.0, 51.0, 53.0, 51.0, 53.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 75.0, 77.0, 77.0, 77.0, 107.0, 76.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 126.0, 113.0, 123.0, 113.0, 136.0, 130.0, 139.0, 133.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 154.0, 154.0, 155.0, 155.0, 160.0, 153.0, 151.0, 157.0], "value": 155.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 64.0, 61.0, 62.0, 60.0, 59.0], "value": 61.2, "unit": "score"}], "name": "kraken", "value": 1476.2999999999997, "alertThreshold": 2.0}]} 02:49:05 INFO - Return code: 0 02:49:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:49:05 ERROR - # TBPL SUCCESS # 02:49:05 INFO - Running post-action listener: _resource_record_post_action 02:49:05 INFO - ##### 02:49:05 INFO - ##### Finished run-tests step (success) 02:49:05 INFO - ##### 02:49:05 INFO - Running post-run listener: _resource_record_post_run 02:49:05 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248528896; Read time: 36; Write time: 138556 02:49:05 INFO - TinderboxPrint: CPU usage
13.1% 02:49:05 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 02:49:05 INFO - TinderboxPrint: I/O write bytes / time
248,528,896 / 138,556 02:49:05 INFO - TinderboxPrint: CPU idle
8,255.1 (86.9%) 02:49:05 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 02:49:05 INFO - TinderboxPrint: Swap in / out
0 / 0 02:49:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1384448; Read time: 0; Write time: 72 02:49:05 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 247144448; Read time: 36; Write time: 138484 02:49:05 INFO - Running post-run listener: _upload_blobber_files 02:49:05 INFO - Blob upload gear active. 02:49:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:49:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:49:06 INFO - (blobuploader) - INFO - Open directory for files ... 02:49:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:49:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:49:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:07 INFO - (blobuploader) - INFO - Done attempting. 02:49:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:49:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:49:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:11 INFO - (blobuploader) - INFO - Done attempting. 02:49:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:49:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:49:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:12 INFO - (blobuploader) - INFO - Done attempting. 02:49:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:49:12 INFO - Return code: 0 02:49:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:49:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:49:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b796606d19eef22de39e7fb1e96397fd354ad119979e46315a1e4721d4bce2341c21dd2d5e0d781e868e2026c6e37817a66c55171055d1043fd00c52a4e9d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15f829e453c392d35b331ca4944e0203a5c3e6db20f03d091094aa3563d145efd51287efc14e718b7a1598bd9b0c8e446987c7889d49b398872a68fbdd08ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75e58a3de6d0c1e61abb33ea8a30fb217f354701a4657c423327b7cf0bcf832aa0395ae2372e85de22287d81ad08774b07eac987a7811b75d4986c1c76638386"} 02:49:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:49:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:49:12 INFO - Contents: 02:49:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b796606d19eef22de39e7fb1e96397fd354ad119979e46315a1e4721d4bce2341c21dd2d5e0d781e868e2026c6e37817a66c55171055d1043fd00c52a4e9d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15f829e453c392d35b331ca4944e0203a5c3e6db20f03d091094aa3563d145efd51287efc14e718b7a1598bd9b0c8e446987c7889d49b398872a68fbdd08ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75e58a3de6d0c1e61abb33ea8a30fb217f354701a4657c423327b7cf0bcf832aa0395ae2372e85de22287d81ad08774b07eac987a7811b75d4986c1c76638386"} 02:49:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:49:12 INFO - Copying logs to upload dir... 02:49:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:49:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1353.544114 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 33 secs) (at 2016-06-07 02:49:11.764268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:11.767954) ========= 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=cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b796606d19eef22de39e7fb1e96397fd354ad119979e46315a1e4721d4bce2341c21dd2d5e0d781e868e2026c6e37817a66c55171055d1043fd00c52a4e9d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15f829e453c392d35b331ca4944e0203a5c3e6db20f03d091094aa3563d145efd51287efc14e718b7a1598bd9b0c8e446987c7889d49b398872a68fbdd08ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75e58a3de6d0c1e61abb33ea8a30fb217f354701a4657c423327b7cf0bcf832aa0395ae2372e85de22287d81ad08774b07eac987a7811b75d4986c1c76638386"} build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b796606d19eef22de39e7fb1e96397fd354ad119979e46315a1e4721d4bce2341c21dd2d5e0d781e868e2026c6e37817a66c55171055d1043fd00c52a4e9d4b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/15f829e453c392d35b331ca4944e0203a5c3e6db20f03d091094aa3563d145efd51287efc14e718b7a1598bd9b0c8e446987c7889d49b398872a68fbdd08ceac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75e58a3de6d0c1e61abb33ea8a30fb217f354701a4657c423327b7cf0bcf832aa0395ae2372e85de22287d81ad08774b07eac987a7811b75d4986c1c76638386"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:11.793942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:11.794319) ========= 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=cbe409c6de289db6ac707de3000001d4-1465291596.742166-1403391174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004781 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:11.878877) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:49:11.879598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:49:11.880196) ========= ========= Total master_lag: 0.24 =========