builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1462363299.48 results: success (0) buildid: 20160504022740 builduid: e6376d9457b54f558950fc8486441392 revision: 36a0266af53801bedff947c56c8d942a8ebb2e5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.479519) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.479974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.480245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.498028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.498636) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 05:01:39-- 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% 224M=0s 2016-05-04 05:01:39 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.639374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.639901) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017784 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.723060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:39.723591) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 36a0266af53801bedff947c56c8d942a8ebb2e5e --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 36a0266af53801bedff947c56c8d942a8ebb2e5e --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=e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 05:01:39,926 truncating revision to first 12 chars 2016-05-04 05:01:39,926 Setting DEBUG logging. 2016-05-04 05:01:39,926 attempt 1/10 2016-05-04 05:01:39,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/36a0266af538?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 05:01:40,260 unpacking tar archive at: mozilla-aurora-36a0266af538/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:40.367651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:40.368191) ========= script_repo_revision: 36a0266af53801bedff947c56c8d942a8ebb2e5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:40.368995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:40.369468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 05:01:40.379324) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 33 secs) (at 2016-05-04 05:01:40.380119) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:40 INFO - MultiFileLogger online at 20160504 05:01:40 in /builds/slave/test 05:01:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:01:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:40 INFO - {'append_to_log': False, 05:01:40 INFO - 'base_work_dir': '/builds/slave/test', 05:01:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:01:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:40 INFO - 'branch': 'Mozilla-Aurora', 05:01:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:40 INFO - 'config_files': ('talos/linux_config.py',), 05:01:40 INFO - 'default_actions': ('clobber', 05:01:40 INFO - 'read-buildbot-config', 05:01:40 INFO - 'download-and-extract', 05:01:40 INFO - 'populate-webroot', 05:01:40 INFO - 'create-virtualenv', 05:01:40 INFO - 'install', 05:01:40 INFO - 'run-tests'), 05:01:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:40 INFO - 'download_minidump_stackwalk': True, 05:01:40 INFO - 'download_symbols': 'ondemand', 05:01:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:40 INFO - 'installer_path': 'installer.exe', 05:01:40 INFO - 'log_level': 'info', 05:01:40 INFO - 'log_name': 'talos', 05:01:40 INFO - 'log_to_console': True, 05:01:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:40 INFO - 'opt_config_files': (), 05:01:40 INFO - 'pip_index': False, 05:01:40 INFO - 'sps_profile': False, 05:01:40 INFO - 'sps_profile_interval': 0, 05:01:40 INFO - 'suite': 'dromaeojs-e10s', 05:01:40 INFO - 'system_bits': '32', 05:01:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:40 INFO - 'title': 'talos-linux64-ix-067', 05:01:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:40 INFO - 'use_talos_json': True, 05:01:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:40 INFO - 'work_dir': 'build'} 05:01:40 INFO - ##### 05:01:40 INFO - ##### Running clobber step. 05:01:40 INFO - ##### 05:01:40 INFO - Running pre-action listener: _resource_record_pre_action 05:01:40 INFO - Running main action method: clobber 05:01:40 INFO - rmtree: /builds/slave/test/build 05:01:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:41 INFO - Running post-action listener: _resource_record_post_action 05:01:41 INFO - ##### 05:01:41 INFO - ##### Running read-buildbot-config step. 05:01:41 INFO - ##### 05:01:41 INFO - Running pre-action listener: _resource_record_pre_action 05:01:41 INFO - Running main action method: read_buildbot_config 05:01:41 INFO - Using buildbot properties: 05:01:41 INFO - { 05:01:41 INFO - "project": "", 05:01:41 INFO - "product": "firefox", 05:01:41 INFO - "script_repo_revision": "production", 05:01:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:01:41 INFO - "repository": "", 05:01:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:01:41 INFO - "buildid": "20160504022740", 05:01:41 INFO - "pgo_build": "True", 05:01:41 INFO - "basedir": "/builds/slave/test", 05:01:41 INFO - "buildnumber": 285, 05:01:41 INFO - "slavename": "talos-linux64-ix-067", 05:01:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:01:41 INFO - "platform": "ubuntu64_hw", 05:01:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:01:41 INFO - "branch": "mozilla-aurora", 05:01:41 INFO - "repo_path": "releases/mozilla-aurora", 05:01:41 INFO - "revision": "36a0266af53801bedff947c56c8d942a8ebb2e5e", 05:01:41 INFO - "stage_platform": "linux64-pgo", 05:01:41 INFO - "builduid": "e6376d9457b54f558950fc8486441392", 05:01:41 INFO - "slavebuilddir": "test" 05:01:41 INFO - } 05:01:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:01:41 INFO - Running post-action listener: _resource_record_post_action 05:01:41 INFO - ##### 05:01:41 INFO - ##### Running download-and-extract step. 05:01:41 INFO - ##### 05:01:41 INFO - Running pre-action listener: _resource_record_pre_action 05:01:41 INFO - Running main action method: download_and_extract 05:01:41 INFO - mkdir: /builds/slave/test/build/tests 05:01:41 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')]} 05:01:41 INFO - https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:02:11 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 05:02:11 INFO - retry: attempt #1 caught exception: timed out 05:02:11 INFO - retry: Failed, sleeping 30 seconds before retrying 05:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 05:03:11 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 05:03:11 INFO - retry: attempt #2 caught exception: timed out 05:03:11 INFO - retry: Failed, sleeping 60 seconds before retrying 05:04:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 05:04:41 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 05:04:41 INFO - retry: attempt #3 caught exception: timed out 05:04:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json! 05:04:41 INFO - Caught exception: timed out 05:04:41 INFO - Caught exception: timed out 05:04:41 INFO - Caught exception: timed out 05:04:41 INFO - trying https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:04:41 INFO - Downloading https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:04:41 INFO - Downloaded 1361 bytes. 05:04:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:04:41 INFO - Using the following test package requirements: 05:04:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:04:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:04:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:04:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'jsshell-linux-x86_64.zip'], 05:04:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:04:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:04:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:04:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:04:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:04:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:04:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:04:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:04:41 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')]} 05:04:41 INFO - https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:05:12 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 05:05:12 INFO - retry: attempt #1 caught exception: timed out 05:05:12 INFO - retry: Failed, sleeping 30 seconds before retrying 05:05:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 05:06:12 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 05:06:12 INFO - retry: attempt #2 caught exception: timed out 05:06:12 INFO - retry: Failed, sleeping 60 seconds before retrying 05:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 05:07:42 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 05:07:42 INFO - retry: attempt #3 caught exception: timed out 05:07:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip! 05:07:42 INFO - Caught exception: timed out 05:07:42 INFO - Caught exception: timed out 05:07:42 INFO - Caught exception: timed out 05:07:42 INFO - trying https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:07:42 INFO - Downloading https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:43 INFO - Downloaded 23824577 bytes. 05:07:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:44 INFO - Return code: 0 05:07:44 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:07:44 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')]} 05:07:44 INFO - https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:07:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:07:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:07:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:08:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 05:08:14 INFO - retry: attempt #1 caught exception: timed out 05:08:14 INFO - retry: Failed, sleeping 30 seconds before retrying 05:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 05:09:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 05:09:14 INFO - retry: attempt #2 caught exception: timed out 05:09:14 INFO - retry: Failed, sleeping 60 seconds before retrying 05:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 05:10:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 05:10:44 INFO - retry: attempt #3 caught exception: timed out 05:10:44 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip! 05:10:44 INFO - Caught exception: timed out 05:10:44 INFO - Caught exception: timed out 05:10:44 INFO - Caught exception: timed out 05:10:44 INFO - trying https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:10:44 INFO - Downloading https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:10:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:10:45 INFO - Downloaded 23824577 bytes. 05:10:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:10:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:10:47 INFO - Return code: 0 05:10: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')]} 05:10:47 INFO - https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:10:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:10:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:11:17 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 05:11:17 INFO - retry: attempt #1 caught exception: timed out 05:11:17 INFO - retry: Failed, sleeping 30 seconds before retrying 05:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 05:12:17 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 05:12:17 INFO - retry: attempt #2 caught exception: timed out 05:12:17 INFO - retry: Failed, sleeping 60 seconds before retrying 05:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 05:13:47 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 05:13:47 INFO - retry: attempt #3 caught exception: timed out 05:13:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip! 05:13:47 INFO - Caught exception: timed out 05:13:47 INFO - Caught exception: timed out 05:13:47 INFO - Caught exception: timed out 05:13:47 INFO - trying https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:13:47 INFO - Downloading https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:13:48 INFO - Downloaded 10840145 bytes. 05:13:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:13:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:13:48 INFO - Return code: 0 05:13:48 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')]} 05:13:48 INFO - https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:13:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:13:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:13:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:14:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 05:14:18 INFO - retry: attempt #1 caught exception: timed out 05:14:18 INFO - retry: Failed, sleeping 30 seconds before retrying 05:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 05:15:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 05:15:18 INFO - retry: attempt #2 caught exception: timed out 05:15:18 INFO - retry: Failed, sleeping 60 seconds before retrying 05:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 05:16:48 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 05:16:48 INFO - retry: attempt #3 caught exception: timed out 05:16:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2! 05:16:48 INFO - Caught exception: timed out 05:16:48 INFO - Caught exception: timed out 05:16:48 INFO - Caught exception: timed out 05:16:48 INFO - trying https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:16:48 INFO - Downloading https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:16:50 INFO - Downloaded 62677360 bytes. 05:16:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:16:50 INFO - mkdir: /builds/slave/test/properties 05:16:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:50 INFO - Contents: 05:16:50 INFO - build_url:https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:16:51 INFO - Running post-action listener: _resource_record_post_action 05:16:51 INFO - Running post-action listener: set_extra_try_arguments 05:16:51 INFO - ##### 05:16:51 INFO - ##### Running populate-webroot step. 05:16:51 INFO - ##### 05:16:51 INFO - Running pre-action listener: _resource_record_pre_action 05:16:51 INFO - Running main action method: populate_webroot 05:16:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:51 INFO - '--tppagecycles', 05:16:51 INFO - '7'], 05:16:51 INFO - 'tests': ['tsvgm']}}, 05:16:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['damp', 'tps']}, 05:16:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'tests': ['damp', 'tps']}, 05:16:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['dromaeo_dom']}, 05:16:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['a11yr', 05:16:51 INFO - 'ts_paint', 05:16:51 INFO - 'tpaint', 05:16:51 INFO - 'sessionrestore', 05:16:51 INFO - 'sessionrestore_no_auto_restore', 05:16:51 INFO - 'tabpaint']}, 05:16:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:51 INFO - 'ts_paint', 05:16:51 INFO - 'tpaint', 05:16:51 INFO - 'sessionrestore', 05:16:51 INFO - 'sessionrestore_no_auto_restore', 05:16:51 INFO - 'tabpaint']}, 05:16:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:51 INFO - 'ts_paint', 05:16:51 INFO - 'tpaint', 05:16:51 INFO - 'sessionrestore', 05:16:51 INFO - 'sessionrestore_no_auto_restore', 05:16:51 INFO - 'tabpaint']}, 05:16:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:51 INFO - 'ts_paint', 05:16:51 INFO - 'tpaint', 05:16:51 INFO - 'sessionrestore', 05:16:51 INFO - 'sessionrestore_no_auto_restore', 05:16:51 INFO - 'tabpaint']}, 05:16:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['a11yr', 05:16:51 INFO - 'ts_paint', 05:16:51 INFO - 'tpaint', 05:16:51 INFO - 'sessionrestore', 05:16:51 INFO - 'sessionrestore_no_auto_restore', 05:16:51 INFO - 'tabpaint']}, 05:16:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['a11yr', 05:16:51 INFO - 'ts_paint', 05:16:51 INFO - 'tpaint', 05:16:51 INFO - 'sessionrestore', 05:16:51 INFO - 'sessionrestore_no_auto_restore', 05:16:51 INFO - 'tabpaint']}, 05:16:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['tsvgx', 05:16:51 INFO - 'tsvgr_opacity', 05:16:51 INFO - 'tart', 05:16:51 INFO - 'tscrollx', 05:16:51 INFO - 'cart']}, 05:16:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:51 INFO - 'tsvgr_opacity', 05:16:51 INFO - 'tart', 05:16:51 INFO - 'tscrollx', 05:16:51 INFO - 'cart']}, 05:16:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'talos_options': ['--disable-e10s'], 05:16:51 INFO - 'tests': ['tp5o']}, 05:16:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'tests': ['tp5o']}, 05:16:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'talos_options': ['--disable-e10s', 05:16:51 INFO - '--xperf_path', 05:16:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:51 INFO - 'tests': ['tp5n']}, 05:16:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:51 INFO - 'talos_options': ['--xperf_path', 05:16:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:51 INFO - 'tests': ['tp5n']}}, 05:16:51 INFO - 'talos.zip': {'path': '', 05:16:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:51 INFO - Running post-action listener: _resource_record_post_action 05:16:51 INFO - ##### 05:16:51 INFO - ##### Running create-virtualenv step. 05:16:51 INFO - ##### 05:16:51 INFO - Running pre-action listener: _resource_record_pre_action 05:16:51 INFO - Running main action method: create_virtualenv 05:16:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:51 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 05:16:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:51 INFO - Using real prefix '/usr' 05:16:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:53 INFO - Installing pip.................done. 05:16:53 INFO - Return code: 0 05:16:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:53 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')]} 05:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:53 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')]} 05:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:53 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 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:16:53 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 05:16:53 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 05:16:53 INFO - Using env: {'DISPLAY': ':0', 05:16:53 INFO - 'HOME': '/home/cltbld', 05:16:53 INFO - 'LANG': 'en_US.UTF-8', 05:16:53 INFO - 'LANGUAGE': 'en_US:en', 05:16:53 INFO - 'LOGNAME': 'cltbld', 05:16:53 INFO - 'MAIL': '/var/mail/cltbld', 05:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:53 INFO - 'MOZ_NO_REMOTE': '1', 05:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:53 INFO - 'NO_EM_RESTART': '1', 05:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:53 INFO - 'PWD': '/builds/slave/test', 05:16:53 INFO - 'SHELL': '/bin/bash', 05:16:53 INFO - 'SHLVL': '1', 05:16:53 INFO - 'TERM': 'linux', 05:16:53 INFO - 'TMOUT': '86400', 05:16:53 INFO - 'USER': 'cltbld', 05:16:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:53 INFO - '_': '/tools/buildbot/bin/python'} 05:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:54 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 05:16:54 INFO - Cleaning up... 05:16:54 INFO - Return code: 0 05:16:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:16:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:16:54 INFO - Using env: {'DISPLAY': ':0', 05:16:54 INFO - 'HOME': '/home/cltbld', 05:16:54 INFO - 'LANG': 'en_US.UTF-8', 05:16:54 INFO - 'LANGUAGE': 'en_US:en', 05:16:54 INFO - 'LOGNAME': 'cltbld', 05:16:54 INFO - 'MAIL': '/var/mail/cltbld', 05:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:54 INFO - 'MOZ_NO_REMOTE': '1', 05:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:54 INFO - 'NO_EM_RESTART': '1', 05:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:54 INFO - 'PWD': '/builds/slave/test', 05:16:54 INFO - 'SHELL': '/bin/bash', 05:16:54 INFO - 'SHLVL': '1', 05:16:54 INFO - 'TERM': 'linux', 05:16:54 INFO - 'TMOUT': '86400', 05:16:54 INFO - 'USER': 'cltbld', 05:16:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:54 INFO - '_': '/tools/buildbot/bin/python'} 05:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:54 INFO - Downloading/unpacking psutil>=0.7.1 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:56 INFO - Installing collected packages: psutil 05:16:56 INFO - Running setup.py install for psutil 05:16:56 INFO - building 'psutil._psutil_linux' extension 05:16:56 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 05:16:56 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 05:16:56 INFO - building 'psutil._psutil_posix' extension 05:16:56 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 05:16:56 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 05:16:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:56 INFO - Successfully installed psutil 05:16:56 INFO - Cleaning up... 05:16:56 INFO - Return code: 0 05:16:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:56 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')]} 05:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:56 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')]} 05:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:16:56 INFO - Using env: {'DISPLAY': ':0', 05:16:56 INFO - 'HOME': '/home/cltbld', 05:16:56 INFO - 'LANG': 'en_US.UTF-8', 05:16:56 INFO - 'LANGUAGE': 'en_US:en', 05:16:56 INFO - 'LOGNAME': 'cltbld', 05:16:56 INFO - 'MAIL': '/var/mail/cltbld', 05:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:56 INFO - 'MOZ_NO_REMOTE': '1', 05:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:56 INFO - 'NO_EM_RESTART': '1', 05:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:56 INFO - 'PWD': '/builds/slave/test', 05:16:56 INFO - 'SHELL': '/bin/bash', 05:16:56 INFO - 'SHLVL': '1', 05:16:56 INFO - 'TERM': 'linux', 05:16:56 INFO - 'TMOUT': '86400', 05:16:56 INFO - 'USER': 'cltbld', 05:16:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:56 INFO - '_': '/tools/buildbot/bin/python'} 05:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:59 INFO - Installing collected packages: mozsystemmonitor 05:16:59 INFO - Running setup.py install for mozsystemmonitor 05:16:59 INFO - Successfully installed mozsystemmonitor 05:16:59 INFO - Cleaning up... 05:16:59 INFO - Return code: 0 05:16:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:59 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')]} 05:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 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')]} 05:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:59 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 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:16:59 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 05:16:59 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 05:16:59 INFO - Using env: {'DISPLAY': ':0', 05:16:59 INFO - 'HOME': '/home/cltbld', 05:16:59 INFO - 'LANG': 'en_US.UTF-8', 05:16:59 INFO - 'LANGUAGE': 'en_US:en', 05:16:59 INFO - 'LOGNAME': 'cltbld', 05:16:59 INFO - 'MAIL': '/var/mail/cltbld', 05:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:59 INFO - 'MOZ_NO_REMOTE': '1', 05:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:59 INFO - 'NO_EM_RESTART': '1', 05:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:59 INFO - 'PWD': '/builds/slave/test', 05:16:59 INFO - 'SHELL': '/bin/bash', 05:16:59 INFO - 'SHLVL': '1', 05:16:59 INFO - 'TERM': 'linux', 05:16:59 INFO - 'TMOUT': '86400', 05:16:59 INFO - 'USER': 'cltbld', 05:16:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:59 INFO - '_': '/tools/buildbot/bin/python'} 05:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:17:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 INFO - Downloading docopt-0.6.1.tar.gz 05:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:02 INFO - Running setup.py install for blobuploader 05:17:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:02 INFO - Running setup.py install for requests 05:17:02 INFO - Running setup.py install for docopt 05:17:02 INFO - Successfully installed blobuploader requests docopt 05:17:02 INFO - Cleaning up... 05:17:02 INFO - Return code: 0 05:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:02 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 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:17:02 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 05:17:02 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 05:17:02 INFO - Using env: {'DISPLAY': ':0', 05:17:02 INFO - 'HOME': '/home/cltbld', 05:17:02 INFO - 'LANG': 'en_US.UTF-8', 05:17:02 INFO - 'LANGUAGE': 'en_US:en', 05:17:02 INFO - 'LOGNAME': 'cltbld', 05:17:02 INFO - 'MAIL': '/var/mail/cltbld', 05:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:02 INFO - 'MOZ_NO_REMOTE': '1', 05:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:02 INFO - 'NO_EM_RESTART': '1', 05:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:02 INFO - 'PWD': '/builds/slave/test', 05:17:02 INFO - 'SHELL': '/bin/bash', 05:17:02 INFO - 'SHLVL': '1', 05:17:02 INFO - 'TERM': 'linux', 05:17:02 INFO - 'TMOUT': '86400', 05:17:02 INFO - 'USER': 'cltbld', 05:17:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:02 INFO - '_': '/tools/buildbot/bin/python'} 05:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:02 INFO - Running setup.py (path:/tmp/pip-8MYYiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:02 INFO - Running setup.py (path:/tmp/pip-h7777G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:02 INFO - Running setup.py (path:/tmp/pip-PwGOZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:03 INFO - Running setup.py (path:/tmp/pip-cZGSjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:03 INFO - Running setup.py (path:/tmp/pip-7CG6gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:03 INFO - Running setup.py (path:/tmp/pip-5AquVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:03 INFO - Running setup.py (path:/tmp/pip-vOF7bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:03 INFO - Running setup.py (path:/tmp/pip-fcYqXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:03 INFO - Running setup.py (path:/tmp/pip-iNlAvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:03 INFO - Running setup.py (path:/tmp/pip-hkLJAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:03 INFO - Running setup.py (path:/tmp/pip-rCiDSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:03 INFO - Running setup.py (path:/tmp/pip-_962ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:03 INFO - Running setup.py (path:/tmp/pip-GsIN2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:03 INFO - Running setup.py (path:/tmp/pip-BdEIti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:03 INFO - Running setup.py (path:/tmp/pip-PgjuZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:03 INFO - Running setup.py (path:/tmp/pip-Wm7cEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:03 INFO - Running setup.py (path:/tmp/pip-Zk9cFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:04 INFO - Running setup.py install for manifestparser 05:17:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Running setup.py install for mozcrash 05:17:04 INFO - Running setup.py install for mozdebug 05:17:04 INFO - Running setup.py install for mozdevice 05:17:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Running setup.py install for mozfile 05:17:04 INFO - Running setup.py install for mozhttpd 05:17:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Running setup.py install for mozinfo 05:17:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Running setup.py install for mozInstall 05:17:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:04 INFO - Running setup.py install for mozleak 05:17:04 INFO - Running setup.py install for mozlog 05:17:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for moznetwork 05:17:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for mozprocess 05:17:05 INFO - Running setup.py install for mozprofile 05:17:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for mozrunner 05:17:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Running setup.py install for mozscreenshot 05:17:05 INFO - Running setup.py install for moztest 05:17:05 INFO - Running setup.py install for mozversion 05:17:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:05 INFO - Cleaning up... 05:17:05 INFO - Return code: 0 05:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:05 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 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:17:05 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 05:17:05 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 05:17:05 INFO - Using env: {'DISPLAY': ':0', 05:17:05 INFO - 'HOME': '/home/cltbld', 05:17:05 INFO - 'LANG': 'en_US.UTF-8', 05:17:05 INFO - 'LANGUAGE': 'en_US:en', 05:17:05 INFO - 'LOGNAME': 'cltbld', 05:17:05 INFO - 'MAIL': '/var/mail/cltbld', 05:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:05 INFO - 'MOZ_NO_REMOTE': '1', 05:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:05 INFO - 'NO_EM_RESTART': '1', 05:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:05 INFO - 'PWD': '/builds/slave/test', 05:17:05 INFO - 'SHELL': '/bin/bash', 05:17:05 INFO - 'SHLVL': '1', 05:17:05 INFO - 'TERM': 'linux', 05:17:05 INFO - 'TMOUT': '86400', 05:17:05 INFO - 'USER': 'cltbld', 05:17:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:05 INFO - '_': '/tools/buildbot/bin/python'} 05:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:06 INFO - Running setup.py (path:/tmp/pip-AwTHol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:06 INFO - Running setup.py (path:/tmp/pip-j5Uxk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:06 INFO - Running setup.py (path:/tmp/pip-MPavWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:06 INFO - Running setup.py (path:/tmp/pip-249AJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:06 INFO - Running setup.py (path:/tmp/pip-pc6VTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:06 INFO - Running setup.py (path:/tmp/pip-zIZgrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:06 INFO - Running setup.py (path:/tmp/pip-vDVjkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:06 INFO - Running setup.py (path:/tmp/pip-tvkSsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:06 INFO - Running setup.py (path:/tmp/pip-tu4hVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:06 INFO - Running setup.py (path:/tmp/pip-9FpVPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:06 INFO - Running setup.py (path:/tmp/pip-P5iz_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:06 INFO - Running setup.py (path:/tmp/pip-zemu7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:06 INFO - Running setup.py (path:/tmp/pip-mFQnDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:06 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)) 05:17:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:06 INFO - Running setup.py (path:/tmp/pip-XKYH_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:07 INFO - Running setup.py (path:/tmp/pip-vDjSIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:07 INFO - Running setup.py (path:/tmp/pip-4CsPvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:07 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)) 05:17:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:07 INFO - Running setup.py (path:/tmp/pip-SGkN89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:07 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)) 05:17:07 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)) 05:17:07 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)) 05:17:07 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)) 05:17:07 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)) 05:17:07 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)) 05:17:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:09 INFO - Downloading blessings-1.6.tar.gz 05:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:09 INFO - Installing collected packages: blessings 05:17:09 INFO - Running setup.py install for blessings 05:17:09 INFO - Successfully installed blessings 05:17:09 INFO - Cleaning up... 05:17:09 INFO - Return code: 0 05:17:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:09 INFO - Reading from file tmpfile_stdout 05:17:09 INFO - Current package versions: 05:17:09 INFO - argparse == 1.2.1 05:17:09 INFO - blessings == 1.6 05:17:09 INFO - blobuploader == 1.2.4 05:17:09 INFO - docopt == 0.6.1 05:17:09 INFO - manifestparser == 1.1 05:17:09 INFO - mozInstall == 1.12 05:17:09 INFO - mozcrash == 0.17 05:17:09 INFO - mozdebug == 0.1 05:17:09 INFO - mozdevice == 0.48 05:17:09 INFO - mozfile == 1.2 05:17:09 INFO - mozhttpd == 0.7 05:17:09 INFO - mozinfo == 0.9 05:17:09 INFO - mozleak == 0.1 05:17:09 INFO - mozlog == 3.1 05:17:09 INFO - moznetwork == 0.27 05:17:09 INFO - mozprocess == 0.22 05:17:09 INFO - mozprofile == 0.28 05:17:09 INFO - mozrunner == 6.11 05:17:09 INFO - mozscreenshot == 0.1 05:17:09 INFO - mozsystemmonitor == 0.0 05:17:09 INFO - moztest == 0.7 05:17:09 INFO - mozversion == 1.4 05:17:09 INFO - psutil == 3.1.1 05:17:09 INFO - requests == 1.2.3 05:17:09 INFO - wsgiref == 0.1.2 05:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 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 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:17:09 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 05:17:09 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 05:17:09 INFO - Using env: {'DISPLAY': ':0', 05:17:09 INFO - 'HOME': '/home/cltbld', 05:17:09 INFO - 'LANG': 'en_US.UTF-8', 05:17:09 INFO - 'LANGUAGE': 'en_US:en', 05:17:09 INFO - 'LOGNAME': 'cltbld', 05:17:09 INFO - 'MAIL': '/var/mail/cltbld', 05:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:09 INFO - 'MOZ_NO_REMOTE': '1', 05:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:09 INFO - 'NO_EM_RESTART': '1', 05:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:09 INFO - 'PWD': '/builds/slave/test', 05:17:09 INFO - 'SHELL': '/bin/bash', 05:17:09 INFO - 'SHLVL': '1', 05:17:09 INFO - 'TERM': 'linux', 05:17:09 INFO - 'TMOUT': '86400', 05:17:09 INFO - 'USER': 'cltbld', 05:17:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:09 INFO - '_': '/tools/buildbot/bin/python'} 05:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 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)) 05:17:09 INFO - Cleaning up... 05:17:09 INFO - Return code: 0 05:17:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 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 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:17:09 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 05:17:09 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 05:17:09 INFO - Using env: {'DISPLAY': ':0', 05:17:09 INFO - 'HOME': '/home/cltbld', 05:17:09 INFO - 'LANG': 'en_US.UTF-8', 05:17:09 INFO - 'LANGUAGE': 'en_US:en', 05:17:09 INFO - 'LOGNAME': 'cltbld', 05:17:09 INFO - 'MAIL': '/var/mail/cltbld', 05:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:09 INFO - 'MOZ_NO_REMOTE': '1', 05:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:09 INFO - 'NO_EM_RESTART': '1', 05:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:09 INFO - 'PWD': '/builds/slave/test', 05:17:09 INFO - 'SHELL': '/bin/bash', 05:17:09 INFO - 'SHLVL': '1', 05:17:09 INFO - 'TERM': 'linux', 05:17:09 INFO - 'TMOUT': '86400', 05:17:09 INFO - 'USER': 'cltbld', 05:17:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:09 INFO - '_': '/tools/buildbot/bin/python'} 05:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:10 INFO - Downloading/unpacking jsonschema 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:10 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 05:17:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:11 INFO - Downloading/unpacking functools32 (from jsonschema) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:12 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:12 INFO - warning: no files found matching '*.txt' 05:17:12 INFO - no previously-included directories found matching 'build' 05:17:12 INFO - no previously-included directories found matching 'dist' 05:17:12 INFO - no previously-included directories found matching '.git*' 05:17:12 INFO - Installing collected packages: jsonschema, functools32 05:17:12 INFO - Running setup.py install for functools32 05:17:12 INFO - warning: no files found matching '*.txt' 05:17:12 INFO - no previously-included directories found matching 'build' 05:17:12 INFO - no previously-included directories found matching 'dist' 05:17:12 INFO - no previously-included directories found matching '.git*' 05:17:12 INFO - Successfully installed jsonschema functools32 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:17:12 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')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 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 0x7fc126a75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd545a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', '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 05:17:12 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 05:17:12 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 05:17:12 INFO - Using env: {'DISPLAY': ':0', 05:17:12 INFO - 'HOME': '/home/cltbld', 05:17:12 INFO - 'LANG': 'en_US.UTF-8', 05:17:12 INFO - 'LANGUAGE': 'en_US:en', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MAIL': '/var/mail/cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SHLVL': '1', 05:17:12 INFO - 'TERM': 'linux', 05:17:12 INFO - 'TMOUT': '86400', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Downloading/unpacking flake8 05:17:12 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 05:17:12 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 05:17:12 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 05:17:12 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 05:17:12 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 05:17:12 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 05:17:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:17:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:17:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:14 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 05:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:15 INFO - no previously-included directories found matching 'docs/_build' 05:17:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:17:15 INFO - Running setup.py install for pep8 05:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:17:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:17:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:17:15 INFO - no previously-included directories found matching 'docs/_build' 05:17:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:17:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:17:15 INFO - Cleaning up... 05:17:15 INFO - Return code: 0 05:17:15 INFO - Running post-action listener: _resource_record_post_action 05:17:15 INFO - Running post-action listener: _start_resource_monitoring 05:17:15 INFO - Starting resource monitoring. 05:17:15 INFO - ##### 05:17:15 INFO - ##### Running install step. 05:17:15 INFO - ##### 05:17:15 INFO - Running pre-action listener: _resource_record_pre_action 05:17:15 INFO - Running main action method: install 05:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:15 INFO - Reading from file tmpfile_stdout 05:17:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:15 INFO - Reading from file tmpfile_stdout 05:17:15 INFO - Output received: 05:17:15 INFO - Usage: mozinstall [options] installer 05:17:15 INFO - Options: 05:17:15 INFO - -h, --help show this help message and exit 05:17:15 INFO - -d DEST, --destination=DEST 05:17:15 INFO - Directory to install application into. [default: 05:17:15 INFO - "/builds/slave/test"] 05:17:15 INFO - --app=APP Application being installed. [default: firefox] 05:17:15 INFO - mkdir: /builds/slave/test/build/application 05:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:17:31 INFO - Reading from file tmpfile_stdout 05:17:31 INFO - Output received: 05:17:31 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:31 INFO - Running post-action listener: _resource_record_post_action 05:17:31 INFO - ##### 05:17:31 INFO - ##### Running run-tests step. 05:17:31 INFO - ##### 05:17:31 INFO - Running pre-action listener: _resource_record_pre_action 05:17:31 INFO - Running main action method: run_tests 05:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:31 INFO - Python 2.7.3 05:17:31 INFO - Return code: 0 05:17:31 INFO - grabbing minidump binary from tooltool 05:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:31 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde3410>, '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 0xde4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:31 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 05:17:31 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 05:17:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:31 INFO - Return code: 0 05:17:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:32 INFO - Return code: 0 05:17:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:17:32 INFO - Using env: {'DISPLAY': ':0', 05:17:32 INFO - 'HOME': '/home/cltbld', 05:17:32 INFO - 'LANG': 'en_US.UTF-8', 05:17:32 INFO - 'LANGUAGE': 'en_US:en', 05:17:32 INFO - 'LOGNAME': 'cltbld', 05:17:32 INFO - 'MAIL': '/var/mail/cltbld', 05:17:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:32 INFO - 'MOZ_NO_REMOTE': '1', 05:17:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:32 INFO - 'NO_EM_RESTART': '1', 05:17:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:32 INFO - 'PWD': '/builds/slave/test', 05:17:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:32 INFO - 'SHELL': '/bin/bash', 05:17:32 INFO - 'SHLVL': '1', 05:17:32 INFO - 'TERM': 'linux', 05:17:32 INFO - 'TMOUT': '86400', 05:17:32 INFO - 'USER': 'cltbld', 05:17:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973', 05:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:32 INFO - '_': '/tools/buildbot/bin/python'} 05:17:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:17:32 INFO - mozversion application_buildid: 20160504022740 05:17:32 INFO - mozversion application_changeset: 36a0266af53801bedff947c56c8d942a8ebb2e5e 05:17:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:17:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:32 INFO - mozversion application_name: Firefox 05:17:32 INFO - mozversion application_remotingname: firefox-dev 05:17:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:17:32 INFO - mozversion application_vendor: Mozilla 05:17:32 INFO - mozversion application_version: 48.0a2 05:17:32 INFO - mozversion platform_buildid: 20160504022740 05:17:32 INFO - mozversion platform_changeset: 36a0266af53801bedff947c56c8d942a8ebb2e5e 05:17:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:17:32 INFO - mozversion platform_version: 48.0a2 05:17:32 INFO - using testdate: 1462364252 05:17:32 INFO - actual date: 1462364252 05:17:32 INFO - starting webserver on 'localhost:51006' 05:17:32 INFO - SUITE-START | Running 2 tests 05:17:32 INFO - TEST-START | dromaeo_css 05:17:32 INFO - operating with platform_type : linux_ 05:17:32 INFO - Initialising browser for dromaeo_css test... 05:17:32 INFO - TEST-INFO | started process 12997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Z9TXL/profile http://localhost:51006/getInfo.html) 05:17:36 INFO - PROCESS | 12997 | 05:17:36 INFO - PROCESS | 12997 | (process:13074): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:17:36 INFO - PROCESS | 12997 | __metrics Screen width/height:1600/1200 05:17:36 INFO - PROCESS | 12997 | colorDepth:24 05:17:36 INFO - PROCESS | 12997 | Browser inner width/height: 1024/697 05:17:36 INFO - PROCESS | 12997 | __metrics 05:17:37 ERROR - PROCESS | 12997 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:17:38 INFO - TEST-INFO | 12997: exit 0 05:17:38 INFO - Browser initialized. 05:17:38 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:38 INFO - TEST-INFO | started process 13125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Z9TXL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:40 INFO - PROCESS | 13125 | 05:17:40 INFO - PROCESS | 13125 | (process:13196): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:17:50 INFO - PROCESS | 13125 | RSS: Main: 152649728 05:17:50 INFO - PROCESS | 13125 | 05:18:39 INFO - PROCESS | 13125 | 1462364319663 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] 05:20:46 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:51006/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51006/tests/dromaeo/cssquery-ext.html) 05:20:47 INFO - PROCESS | 13125 | RSS: Main: 155643904 05:20:47 INFO - PROCESS | 13125 | 05:23:49 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:51006/tests/dromaeo/cssquery-ext.html (next: http://localhost:51006/tests/dromaeo/cssquery-jquery.html) 05:23:50 INFO - PROCESS | 13125 | RSS: Main: 155009024 05:23:50 INFO - PROCESS | 13125 | 05:26:52 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:51006/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51006/tests/dromaeo/cssquery-mootools.html) 05:26:52 INFO - PROCESS | 13125 | RSS: Main: 153944064 05:26:52 INFO - PROCESS | 13125 | 05:29:54 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:51006/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51006/tests/dromaeo/cssquery-prototype.html) 05:29:54 INFO - PROCESS | 13125 | RSS: Main: 153849856 05:29:54 INFO - PROCESS | 13125 | 05:32:57 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:51006/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51006/tests/dromaeo/cssquery-yui.html) 05:32:57 INFO - PROCESS | 13125 | RSS: Main: 155226112 05:32:57 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | Cycle 1(1): loaded http://localhost:51006/tests/dromaeo/cssquery-yui.html (next: http://localhost:51006/tests/dromaeo/cssquery-dojo.html) 05:36:00 INFO - PROCESS | 13125 | RSS: Main: 156053504 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | __start_tp_report 05:36:00 INFO - PROCESS | 13125 | _x_x_mozilla_page_load 05:36:00 INFO - PROCESS | 13125 | _x_x_mozilla_page_load_details 05:36:00 INFO - PROCESS | 13125 | |i|pagename|runs| 05:36:00 INFO - PROCESS | 13125 | |0;dojo.html;3320.9169770755734;3363.276895467474;3378.814165220912;3391.949120763189;3393.9321213575745;5578.497935185837;5589.105743081108;5599.440055994399;5620.690862002588;5627.803026894059;5555.194496797972;5573.247611572437;5600.327960644729;5606.187102870082;5615.2700148980675;5033.874153146173;5093;5135.178371460567;5135.409427915782;5152.562032227265;5005.174146265862;5107.719075450848;5201.9479805201845;5206.817761378353;5239.476052394768;5073.670211436263;5134.871628209287;5160.993606246783;5195.142801437777;5224.164133738603;5120.948790512084;5129.358830146231;5146.305248791403;5146.665466744649;5183.0670479314085;4792.281157826319;5043.873903152414;5047.041062198207;5087.56755675768;5115;5316.601254905898;5336.466353364633;5373.973130134364;5406.972965135188;5407.215953686693;5860.267466566679;5872;5880.26496687914;5885.205497257901;5909.290885093773;5799.8550036249435;5874.707564335839;5894.204282421861;5913.113033045035;5935.050391937312;5537.252470916455;5552.555795536347;5553.583481238923;5559.19391688207;5592.468715472024;5987.880242395127;5988.161657367972;5994.970025149846;5995.070764031582;6020.819375418744;5676.120201368794;5707.143928410772;5796.956547821433;5800.216970708984;5807.622504537191;5920.378360272195;5921.319048309413;5924.733386997509;5925.555583331267;5946.702664866826;5848.64908105515;5875.676837773878;5889.293284805851;5902.822915312548;5905.143754155623;5781.248437703156;5816.447437493432;5923.644581325134;5950.553708471882;5976.641401515836;4491.348754430589;4512.165249428801;4513.300438432048;4513.435820522434;4524.321351797257;4055.1078762672164;4057.918841623151;4064.6383461540713;4086.1214838809206;4097.405876147942;5532.474414930575;5557.638753481011;5657.830265092054;5770.365259821417;5803.303603567599;5929.0513517836935;5966.791162309299;5967.283925928917;5983.970080149571;6035.849103772353;5682.54539636828;5694.5159661428415;5697.401772813795;5698.857528561819;5703.372629010805;4993.525615066563;5031.371078615173;5091.770870310845;5101.69389836611;5142.357205349332;6149.538784591174;6170.259568851677;6171.259448866164;6179.412955769195;6195.473384762346;5931.792387266425;5937.821865344046;5969.224000879858;5979.282486101695;5987.940120598825;6012.909806352821;6117.908231376622;6148.1085242640465;6162.168107305636;6180.7527698891545;5810.215620891126;5844.298684157929;5852.356240813422;5870.383609720918;5870.882582348415;5963.135345374983;5963.612365196248;5963.73163207648;5965.761369545343;5972.522198224045;5727.369989301257;5758.8848223034465;5762.193292939076;5812.883742325214;5846.883062338815;5751.769929202785;5783.103618939072;5813.593048486566;5819.76720931158;5823.242978412779;5685.204071430086;5720.427957204246;5742.19609254713;5750.856228594319;5757.424257574209;5715.971420142872;5821.068629019336;5825.388334225015;5887.764489420375;5895.793647222326;5662.745176467151;5673.149027645886;5707.8858422832145;5710.428957104256;5735.340435849764 05:36:00 INFO - PROCESS | 13125 | |1;ext.html;622.8536293970916;647.2427260105676;656.8948968165095;669.2504395077514;681.1621705302481;40205.59794402055;41885.371719424234;42015.369769453486;42081.15837683244;42162.78918605406;41138.58861411385;41574.37638435426;41736.791316043455;41870;41911.79044104783;8887.911120888773;8999.325050621197;9080.137386948229;9103.36276460648;9126.589303481325;9000.144986226298;9034.14175653312;9062.546872656341;9087.227585655228;9124.635014599407;9080.228180604623;9126.087391260888;9166;9183.40307879989;9195.494247816367;9054.86417703735;9119.088091190893;9136.132067453615;9147.359684822066;9171.724848254564;8895.822083558358;9109.180173784325;9150.49672268025;9153.588088536031;9203.953980230122;31518;42983;43531.347029794575;43602.563974360164;43710;3428.263193119512;3670.7797532148156;3697.9815100924593;4014.5383280922483;4381.364702118175;29497.557536636967;29932.102036938926;29944.550831737542;30042.24894377636;31125;4447.466304043503;4451.688381813275;4485.349624304457;4516.774161291923;4615.699979501322;254383;257501;258247.9999999981;258987;260642.69678651675;36689.633103668624;37251;37409;37568.62431375651;38571.80714096411;37640.43539346912;37655.24689506249;38078.42882356767;38154.42768358477;38242;17426.21582028812;17564.736528952075;17593.208305626278;17604.119794010505;17613.119344033003;14221.14673119616;14331;14349.78475322871;14373.99382043247;14517.201553914636;9503.619855205714;9559.394990135614;9631.951840240894;9638.807223855483;9690.70927872165;3553.857845686195;3615.439606860941;3644.1982763791925;3674.6141655125825;3692.1508053147927;1043.0299821166388;1147.6671765188169;1160.5357856857324;1183.3964678014274;1185.3184418959133;33053;33614.15964600856;33715.325693486;33925;34003;1199.7780410623889;1200.0819373179525;1214.5688280660415;1229.8339724137127;1266.860645329013;17850.464486065437;17948.37180698669;18065.54836129081;18089.185986630633;18299.451016469528;331431;342724;348951;499362;510564;60936.39063609396;62250;62445;62502;62691.686541567;796.7530065679658;1344.3211178354868;1517.5068102866612;1529.4341093795144;1530.833870073833;33617.495737564444;33746.66253337435;34274.485882711284;34501.827490862386;34577.654223457444;55811.72094139503;56988.145177821534;57066.42933570611;57147.714261428424;57271.42728572661;483976;486559;486861;487994;489259;31243.84378078095;31390.215244619067;31644.367112657157;31754.206144846565;31970.52044219385;51154;51370.486295138064;51397.74301128471;51913.74043129911;52037.21944170916;43280.134397312504;43435.56564434315;43661.56338436702;43738.56261437345;45231.095378091595;38553.614463855;42719.786401067795;43059;43112.35331469968;43588.56411435972;40306.1938761229;40884.18231635291;41062;41226.58773412227;41326.79336603298;35535.28929421346;37276.813615931744;37421.25157496889;37675.62324376831;38485;29524.261893452836;29758.404831903674;29948;29950.850245748632;30341.241468963453 05:36:00 INFO - PROCESS | 13125 | |2;jquery.html;428.26339689384815;435.1167130724629;437.6476687037055;443.45455090239005;449.86504048785355;18783.906080469595;19310.227590896364;19367.515812104688;21156.25953091642;21252;19224.846509209423;19651.705224421647;20197.293094741686;20335.796642033576;20459.48851278719;5836.6789826559625;5998;6004;6009.06859436788;6035.853187894308;5709.514691251248;5901.557383196277;5964.433378829004;5967.791127310545;5975.25309336333;5777.480026797587;5806.564507661921;5894.263217097863;5894.4989675877605;5899.495628614719;5769.509591684712;5775.711214439261;5913.615614985012;5946.316173640043;5953.404659534055;5245.659032162897;5304.336957880265;5311.521963023347;5315.867103322409;5371.274877891474;23205.88397058021;23387.305828630775;23542.17602383908;23798.405039873967;24196.758032419628;2513.899444022237;2582.2769624505167;2612.3991481959256;2912.7087291270705;2958.6301712285963;14776.778348324784;15066.322015509219;15092.471763488335;15123.470678526199;15273.923630381776;1948.298612499499;2048.365006847867;2074.968875466869;2103.1377135374423;2148.581026699794;86733;88305.55847220786;88630.556847216;90112;91243.54378228133;11173.268143437781;11387.918147775948;11539.596114135966;11586.246893951866;11733.237339572901;16245;16321.83678163227;16404.09777462227;16411.1794410279;16435.424760133337;8895.154960278764;8987.19115279628;9130.589123489459;9138.451692898447;9178.705323669083;8989.190972812348;9001.684941027033;9042.547872606343;9198.98811130775;9230.07699230085;6921.861562768817;7099.325564071405;7183.353498185188;7188;7263.927360726325;1993.880367177974;2058.475088852333;2076.3874656976227;2083.895805209733;2102.432343267309;944.9196818270524;1040.599369242847;1079.1312993040679;1106.446776611694;1121.103117505992;19766.50583735418;19790.70313945292;20074.79925200729;20183.59632807365;20373.694394584094;1070.7644318249972;1085.495244711213;1086.3916206924148;1119.339589642115;1136.6249137784512;11341.603043893425;11614.6515604532;11687.415629218505;11771.646850594496;11776.705582360339;507014;512397;543902;551622;552824;104726.4763676192;105413.47293263485;107315.46342268396;108031.45984270185;109966;1057.8201705709894;1073.4203530093819;1098.6045023791428;1116.4417791104286;1118.3960661243;16832.07423591714;16969.32122715127;17890.642187155925;17945.910270448563;18199;41346.79326603348;41507.37738933979;42182.578174217866;43140;43341.3498797512;58237.12644310254;59991.70004150126;60167.39832601618;60661;60757.69621151866;8648.30813534903;8989.235914947303;9141.405808622418;9186.632534698805;9250.907490925005;13259.337033148497;13861.346831422517;14489.782653260421;14534.345954431865;14781;11857.5849845255;12387.69030774238;12455.501779928702;12658.936705316415;12723.80914286268;7913.920860791319;10154.035366640157;12337.136400451882;12625.675466652134;13247.801282980956;12685.302308373128;12848.486060557472;12877.162984405984;12946;13017.934910325388;9377.343585948918;9410.435373877315;9419.670311539063;9445.669401570913;9569.952150239204;12600.495980160691;12993.870061299265;13078.607641770763;13148.934255329044;13220.933895330461 05:36:00 INFO - PROCESS | 13125 | |3;mootools.html;1562.617158796095;1579.510351790945;1835.5227640813384;1898.4399602117373;1928.373278684428;8094.190580941903;8429.91570084299;8576.14238576142;8737.951445826502;8751.693690720818;8644.092370301121;8663.306935445165;8670.826583468326;8677.219050285488;8736;2347.5187586544803;2365.1012615206196;2366.8461549999283;2373.6320870265135;2383.5113801670705;2395.4849707312924;2412.9034838606435;2448.461338505526;2452.3746444656585;2456.103522214397;2433.2578563538113;2434.075051480435;2454.1533171055958;2456.5823809952353;2467.5064987002584;2383.1420688552193;2383.511380167062;2391.5814732421754;2395.47299594089;2430.1008626808016;2366.479374537616;2374.014783864694;2378.63131214662;2383.6067048936907;2400.4238982644038;8884.978227503856;8928.776780580472;8945.284377249804;8946.373753837233;8958.776030599221;5106.387233531963;5247.658902171346;5258.973705131488;5264.026155161269;5293.285406470116;3333.96666033339;3350.1792060945227;3414.334204830034;3467.4452087666104;3469.4795780632853;1137.590467431724;1138.7494751154732;1148.5004023249912;1163.3834067944003;1181.3856794466915;11155.609553665663;11159.107271418266;11191.888081119167;11224.32654040752;11331.716707082307;4587.655925805578;4655.813767449332;4657.790399432034;4689.1559519286175;4751.928721069186;9669.081437263589;9678.95160524193;9691.07934746198;9695.078967498077;9724.70825875225;5163.793448262102;5227.817026404134;5264.184051472028;5301.469853014745;5343.70609616467;4580.908381832344;4767.070421267889;4795.256735206049;4804.5195480451675;4897.510248975074;4078.775667338325;4158.91682166355;4256;4257;4273.658107351404;1308.8691130887025;1311.967200819987;1322.107577385261;1323.9867601324056;1336.3986206207246;1038.3977293169944;1052.5316234275826;1053.5838343854134;1057.836035414512;1064.2443864855884;5931.3178984417345;5975.163477113208;6030.517558595302;6119.5410344224365;6146.692665366714;455.04213630308385;459.4165409929371;473.96919200251875;476.12155572967816;482.6597248939489;4117.3618089196225;4183.414321994923;4222.408862759216;4248.192843359751;4284.357346398003;10590.523426445674;11116.110711143088;11125.666230013112;11251.718707032389;11275.436228188722;11027.44862756859;11104.222704410775;11121.110311175087;11127.443627818577;11129.944350278196;8218.465799722999;8385.790355241168;8388.622511986976;8467.364947628952;8559.058503564604;5915.438033386821;6055.061465472859;6064.727087280995;6135.662538560422;6180.47465965398;10081.546330415296;10224.13094886943;10254.128399085863;10305.74235644115;10504.947475262576;10296.227782916161;10505.264631475724;10511.526981285708;10512.789744205225;10554.10290125348;7245.891311630435;7612.7716168515035;7888.605569721376;7968.601569921597;8071.717489887826;8393.95803020981;8428.199321064489;8496.06543280251;8524.27543658796;8536.402451828313;7574.204708505527;7884.881726774218;8051.637676304464;8076.192380761877;8280.50316980983;8009.359251260002;8049.315808156372;8110.716124935599;8158.877616835871;8163.020437547532;7131.500794944304;7348.191698913222;7378.778636640909;7470.626468676436;7472.140703818913;5468.617196796186;5479.698616575967;5507.586930980273;5518.641288316247;5596.3284405871555;5534.833954981196;5602.4957753802355;5603.551715862803;5633.0705433603;5710.8001219957105 05:36:00 INFO - PROCESS | 13125 | |4;prototype.html;351.8838783201544;359.0735901374454;365.90120667419797;370.616412013566;371.5392912788142;5634.859128521789;5674.602777805555;5719.14212868069;5806.216160818293;5806.883862322757;5645.887082258352;5700.230468886699;5703.800366987156;5726.541876649869;5753.482186603205;4417.3815665806815;4465.620422264095;4474.194644963905;4476.462824461069;4497.280435130379;4409.5149533551285;4410.9779451102695;4482.574155455227;4487.214737420938;4496.213162696515;4442.466903971528;4453.888652783674;4454.57681520255;4459.710118842281;4468.50846406895;4469.435697505864;4471.195184866723;4482.439695038121;4488.281874900033;4523.819047238107;3698.1863989922176;3891.299566078105;3999.900002499932;4000.4599379084034;4001.8199181036925;5413.945860541384;5501.834944951618;5508.944910550923;5509.256250406224;5509.622594351412;5030.421501527335;5077.26379674945;5080.923786143211;5089.287499750038;5102.795888164469;5704.258446401941;5928.229330187048;5944.176516154836;5945.346011938684;5976.850578735566;4278.893027674302;4287.699861009731;4292.527821939584;4293.819199720071;4313.611774940239;6147.569670123048;6258.655773932432;6260.812175634738;6269.87460250797;6320.273168585625;4259.382389553497;4261.296886013773;4342.5657434256955;4346.978265108654;4357.150355680612;4402.647788176938;4406.449193850769;4443.311286750559;4445.355423463579;4464.955350446454;5080.288759573663;5092.6435149539175;5094.286799848024;5102.158143906214;5104;5842.795502157404;5856.150858125633;6016.909746353808;6029.517638588903;6054.455099041107;1591.7930669012953;1603.8877278590387;1603.9679206415806;1605.5183444966463;1614.7577863320362;1047.486731501574;1050.726811029138;1056.1761825775907;1092.5192915117323;1104.1884215101893;6329.208848893888;6376.107344971708;6379.840503987344;6381.489480841522;6390.297067322591;6590.439812615886;6654.700538475683;6657.434118100015;6659.9001014984815;6701.932980670228;5685.403032681592;5964.8807023860145;5976.820695379146;5998.820035398945;6046.304674962347;3614.4578313253223;3628.2017956049626;3630.636936306348;3634.1459756957092;3637.872674456434;6255.6872156392;6479.1901012373455;6491.747905122153;6557.967210163919;7033.437325013987;6411.3909178627955;6420.967895160495;6427.389398007182;6435.942927109585;6444.130042444303;6306.653134077578;6473.255575608771;6484.675766211576;6498.277956341573;6551.80344589663;6208;6217.285012223652;6255.311915689362;6299.496040316672;6307.842303942438;5951.851203719769;6183.505319574333;6197.5351848610635;6207.16203312547;6247.6563788990225;6477.190351206099;6535.150430444012;6587.715395497832;6593.3736295051895;6601.141851559267;4425.3140763181755;4425.446819147606;4448.866534003985;4472.508024117409;4478.731276123443;6110.450059494667;6119.388061193845;6267;6282.591631544118;6312;6157.029750479804;6157.384261573807;6173.938260617337;6187.535934804818;6191.4118158774845;5957.940420595912;6114.296855861455;6145.262568491809;6147.385261473817;6152.907706384497;5909.8227053188475;5933.033483258371;5975.521958243417;5985.221921150222;5988.251468566429;6123.173371594956;6123.510119190543;6136.637394603021;6185.010398336424;6193.4425901669065;5743.712814359182;5920.703964801829;5922.200502932049;5990.023292313439;6037.335893051673 05:36:00 INFO - PROCESS | 13125 | |5;yui.html;764.8929149919011;841.688575227166;843.6878355008648;877.8024944387514;907.2696479334141;13471.865281347184;13786.172829630217;14106.78839817401;14167.85832141677;14175.291235438213;12210.206336588115;12553.560625378113;12600;12651.936740316309;12687.111902166853;725.365305357812;857.8241460500583;879.1296616349799;890.3411475508142;894.2577660541767;881.5460038080394;883.6818745251704;885.313881741649;887;887.3344991256557;925.8842644669417;932.39394393644;933.8179055084262;933.869258303838;935.6818681648239;925.1673493855517;926.536731634183;930.7533503621546;934.1359242700509;936.2322895225883;683.7094234950126;684.0218487562784;685.7120009595932;685.9759908403232;687.60806340386;12797.808032879515;12882.549110781078;12900.419481123372;12917.67705807353;12989.350532473432;12750.29873356965;12773.808392874114;12811.423485943154;13061.21632702041;13255.337233138402;10662.840057399146;10714.571417143305;10735.248532602722;10804.945975270151;11024.669259922215;3638.5088013118157;3651;3664.926701465982;3749.512563366745;3755.455458958436;50554.74722626364;51072;56613.15080273758;56856;57023.714881425745;9470.763230919281;9748.220142388593;9783.902160978441;9815.11663950248;9969.152622027208;18204.180811863498;18328.358507452176;18339.908300458414;18341.358052468368;18429.53926151857;7609.086909570776;7799.649015794303;7890.526568405914;8002.8799568006525;8141.389395795339;4406.5593440655675;4418.513963464016;4480.14877173336;4514.187446259639;4529.592336689714;3306.454435018195;3364.091695242271;3461.1693193633346;3464.7921124732093;3476;649.3311888754496;649.561545956487;651.8500744828716;654.3685343643407;657.7336178847575;798.253632853284;799.2407213147533;804.5454318310253;818.9385796065319;850.6597361055503;9041.909580904106;9125.634974601075;9197.356185066981;9354.812903741888;9406.341556091007;685.7497013590004;746.6490749347798;783.5298820707529;795.6379847169524;800.087899794235;4294.677899157513;4331.393604895317;4423.270160423494;4465.330200469955;4492.258777301774;62009.68995154995;62092;63623;63732.36267637357;72350;52145.47854521482;54543.45456545463;55479;59446.70276648589;61685.383146167966;55856.44143558593;56718.71640641853;56935.43064569384;57218.71390643103;57508;9735;9820.950895245478;9898.208143348658;9952.502374881371;10021.899781002388;33283.66716332806;33919.83040084784;34341.141471463416;36374.45438318374;37712.057198570255;50770;50878.74560627173;51375.48624513707;51661;52517.21224181717;12620.495180192689;12633.2420054797;12910.483580656668;12929.741405172032;12992.285424301754;12486.687832804253;12628.116031878048;12808.871911280768;12875.806862896876;12985.675358116123;12834.55079072228;13113.278769667379;13197.80203296932;13286.335683215608;13523.188608683511;12570.560030398892;12739.363031848556;12747.808782868078;12892.355382231039;12949.158304710163;12049.819252711392;12079.637610871689;12137.150399471951;12319.44562494672;12476.06429517808;10941.726456838644;10977.945110274397;11078.224524283223;11127.221094523306;11491.310521368745;10719.946400267949;11145.331280123219;11170.441477925908;11277.661670149908;11296.265742726697 05:36:00 INFO - PROCESS | 13125 | __end_tp_report 05:36:00 INFO - PROCESS | 13125 | __start_cc_report 05:36:00 INFO - PROCESS | 13125 | _x_x_mozilla_cycle_collect,321 05:36:00 INFO - PROCESS | 13125 | __end_cc_report 05:36:00 INFO - PROCESS | 13125 | __startTimestamp1462365360252__endTimestamp 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | ------- Summary: start ------- 05:36:00 INFO - PROCESS | 13125 | Number of tests: 6 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | [#0] dojo.html Cycles:165 Average:5521.16 Median:5727.37 stddev:597.94 (10.4%) stddev-sans-first:574.32 05:36:00 INFO - PROCESS | 13125 | Values: 3320.9 3363.3 3378.8 3391.9 3393.9 5578.5 5589.1 5599.4 5620.7 5627.8 5555.2 5573.2 5600.3 5606.2 5615.3 5033.9 5093.0 5135.2 5135.4 5152.6 5005.2 5107.7 5201.9 5206.8 5239.5 5073.7 5134.9 5161.0 5195.1 5224.2 5120.9 5129.4 5146.3 5146.7 5183.1 4792.3 5043.9 5047.0 5087.6 5115.0 5316.6 5336.5 5374.0 5407.0 5407.2 5860.3 5872.0 5880.3 5885.2 5909.3 5799.9 5874.7 5894.2 5913.1 5935.1 5537.3 5552.6 5553.6 5559.2 5592.5 5987.9 5988.2 5995.0 5995.1 6020.8 5676.1 5707.1 5797.0 5800.2 5807.6 5920.4 5921.3 5924.7 5925.6 5946.7 5848.6 5875.7 5889.3 5902.8 5905.1 5781.2 5816.4 5923.6 5950.6 5976.6 4491.3 4512.2 4513.3 4513.4 4524.3 4055.1 4057.9 4064.6 4086.1 4097.4 5532.5 5557.6 5657.8 5770.4 5803.3 5929.1 5966.8 5967.3 5984.0 6035.8 5682.5 5694.5 5697.4 5698.9 5703.4 4993.5 5031.4 5091.8 5101.7 5142.4 6149.5 6170.3 6171.3 6179.4 6195.5 5931.8 5937.8 5969.2 5979.3 5987.9 6012.9 6117.9 6148.1 6162.2 6180.8 5810.2 5844.3 5852.4 5870.4 5870.9 5963.1 5963.6 5963.7 5965.8 5972.5 5727.4 5758.9 5762.2 5812.9 5846.9 5751.8 5783.1 5813.6 5819.8 5823.2 5685.2 5720.4 5742.2 5750.9 5757.4 5716.0 5821.1 5825.4 5887.8 5895.8 5662.7 5673.1 5707.9 5710.4 5735.3 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | [#1] ext.html Cycles:180 Average:54640.44 Median:40973.09 stddev:105577.96 (257.7%) stddev-sans-first:105796.24 05:36:00 INFO - PROCESS | 13125 | Values: 622.9 647.2 656.9 669.3 681.2 40205.6 41885.4 42015.4 42081.2 42162.8 41138.6 41574.4 41736.8 41870.0 41911.8 8887.9 8999.3 9080.1 9103.4 9126.6 9000.1 9034.1 9062.5 9087.2 9124.6 9080.2 9126.1 9166.0 9183.4 9195.5 9054.9 9119.1 9136.1 9147.4 9171.7 8895.8 9109.2 9150.5 9153.6 9204.0 31518.0 42983.0 43531.3 43602.6 43710.0 3428.3 3670.8 3698.0 4014.5 4381.4 29497.6 29932.1 29944.6 30042.2 31125.0 4447.5 4451.7 4485.3 4516.8 4615.7 254383.0 257501.0 258248.0 258987.0 260642.7 36689.6 37251.0 37409.0 37568.6 38571.8 37640.4 37655.2 38078.4 38154.4 38242.0 17426.2 17564.7 17593.2 17604.1 17613.1 14221.1 14331.0 14349.8 14374.0 14517.2 9503.6 9559.4 9632.0 9638.8 9690.7 3553.9 3615.4 3644.2 3674.6 3692.2 1043.0 1147.7 1160.5 1183.4 1185.3 33053.0 33614.2 33715.3 33925.0 34003.0 1199.8 1200.1 1214.6 1229.8 1266.9 17850.5 17948.4 18065.5 18089.2 18299.5 331431.0 342724.0 348951.0 499362.0 510564.0 60936.4 62250.0 62445.0 62502.0 62691.7 796.8 1344.3 1517.5 1529.4 1530.8 33617.5 33746.7 34274.5 34501.8 34577.7 55811.7 56988.1 57066.4 57147.7 57271.4 483976.0 486559.0 486861.0 487994.0 489259.0 31243.8 31390.2 31644.4 31754.2 31970.5 51154.0 51370.5 51397.7 51913.7 52037.2 43280.1 43435.6 43661.6 43738.6 45231.1 38553.6 42719.8 43059.0 43112.4 43588.6 40306.2 40884.2 41062.0 41226.6 41326.8 35535.3 37276.8 37421.3 37675.6 38485.0 29524.3 29758.4 29948.0 29950.9 30341.2 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | [#2] jquery.html Cycles:180 Average:31517.07 Median:21204.13 stddev:88171.62 (415.8%) stddev-sans-first:88388.07 05:36:00 INFO - PROCESS | 13125 | Values: 428.3 435.1 437.6 443.5 449.9 18783.9 19310.2 19367.5 21156.3 21252.0 19224.8 19651.7 20197.3 20335.8 20459.5 5836.7 5998.0 6004.0 6009.1 6035.9 5709.5 5901.6 5964.4 5967.8 5975.3 5777.5 5806.6 5894.3 5894.5 5899.5 5769.5 5775.7 5913.6 5946.3 5953.4 5245.7 5304.3 5311.5 5315.9 5371.3 23205.9 23387.3 23542.2 23798.4 24196.8 2513.9 2582.3 2612.4 2912.7 2958.6 14776.8 15066.3 15092.5 15123.5 15273.9 1948.3 2048.4 2075.0 2103.1 2148.6 86733.0 88305.6 88630.6 90112.0 91243.5 11173.3 11387.9 11539.6 11586.2 11733.2 16245.0 16321.8 16404.1 16411.2 16435.4 8895.2 8987.2 9130.6 9138.5 9178.7 8989.2 9001.7 9042.5 9199.0 9230.1 6921.9 7099.3 7183.4 7188.0 7263.9 1993.9 2058.5 2076.4 2083.9 2102.4 944.9 1040.6 1079.1 1106.4 1121.1 19766.5 19790.7 20074.8 20183.6 20373.7 1070.8 1085.5 1086.4 1119.3 1136.6 11341.6 11614.7 11687.4 11771.6 11776.7 507014.0 512397.0 543902.0 551622.0 552824.0 104726.5 105413.5 107315.5 108031.5 109966.0 1057.8 1073.4 1098.6 1116.4 1118.4 16832.1 16969.3 17890.6 17945.9 18199.0 41346.8 41507.4 42182.6 43140.0 43341.3 58237.1 59991.7 60167.4 60661.0 60757.7 8648.3 8989.2 9141.4 9186.6 9250.9 13259.3 13861.3 14489.8 14534.3 14781.0 11857.6 12387.7 12455.5 12658.9 12723.8 7913.9 10154.0 12337.1 12625.7 13247.8 12685.3 12848.5 12877.2 12946.0 13017.9 9377.3 9410.4 9419.7 9445.7 9570.0 12600.5 12993.9 13078.6 13148.9 13220.9 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | [#3] mootools.html Cycles:180 Average:5855.80 Median:4673.47 stddev:3252.67 (69.6%) stddev-sans-first:3245.79 05:36:00 INFO - PROCESS | 13125 | Values: 1562.6 1579.5 1835.5 1898.4 1928.4 8094.2 8429.9 8576.1 8738.0 8751.7 8644.1 8663.3 8670.8 8677.2 8736.0 2347.5 2365.1 2366.8 2373.6 2383.5 2395.5 2412.9 2448.5 2452.4 2456.1 2433.3 2434.1 2454.2 2456.6 2467.5 2383.1 2383.5 2391.6 2395.5 2430.1 2366.5 2374.0 2378.6 2383.6 2400.4 8885.0 8928.8 8945.3 8946.4 8958.8 5106.4 5247.7 5259.0 5264.0 5293.3 3334.0 3350.2 3414.3 3467.4 3469.5 1137.6 1138.7 1148.5 1163.4 1181.4 11155.6 11159.1 11191.9 11224.3 11331.7 4587.7 4655.8 4657.8 4689.2 4751.9 9669.1 9679.0 9691.1 9695.1 9724.7 5163.8 5227.8 5264.2 5301.5 5343.7 4580.9 4767.1 4795.3 4804.5 4897.5 4078.8 4158.9 4256.0 4257.0 4273.7 1308.9 1312.0 1322.1 1324.0 1336.4 1038.4 1052.5 1053.6 1057.8 1064.2 5931.3 5975.2 6030.5 6119.5 6146.7 455.0 459.4 474.0 476.1 482.7 4117.4 4183.4 4222.4 4248.2 4284.4 10590.5 11116.1 11125.7 11251.7 11275.4 11027.4 11104.2 11121.1 11127.4 11129.9 8218.5 8385.8 8388.6 8467.4 8559.1 5915.4 6055.1 6064.7 6135.7 6180.5 10081.5 10224.1 10254.1 10305.7 10504.9 10296.2 10505.3 10511.5 10512.8 10554.1 7245.9 7612.8 7888.6 7968.6 8071.7 8394.0 8428.2 8496.1 8524.3 8536.4 7574.2 7884.9 8051.6 8076.2 8280.5 8009.4 8049.3 8110.7 8158.9 8163.0 7131.5 7348.2 7378.8 7470.6 7472.1 5468.6 5479.7 5507.6 5518.6 5596.3 5534.8 5602.5 5603.6 5633.1 5710.8 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | [#4] prototype.html Cycles:180 Average:5140.62 Median:5779.85 stddev:1522.09 (26.3%) stddev-sans-first:1483.32 05:36:00 INFO - PROCESS | 13125 | Values: 351.9 359.1 365.9 370.6 371.5 5634.9 5674.6 5719.1 5806.2 5806.9 5645.9 5700.2 5703.8 5726.5 5753.5 4417.4 4465.6 4474.2 4476.5 4497.3 4409.5 4411.0 4482.6 4487.2 4496.2 4442.5 4453.9 4454.6 4459.7 4468.5 4469.4 4471.2 4482.4 4488.3 4523.8 3698.2 3891.3 3999.9 4000.5 4001.8 5413.9 5501.8 5508.9 5509.3 5509.6 5030.4 5077.3 5080.9 5089.3 5102.8 5704.3 5928.2 5944.2 5945.3 5976.9 4278.9 4287.7 4292.5 4293.8 4313.6 6147.6 6258.7 6260.8 6269.9 6320.3 4259.4 4261.3 4342.6 4347.0 4357.2 4402.6 4406.4 4443.3 4445.4 4465.0 5080.3 5092.6 5094.3 5102.2 5104.0 5842.8 5856.2 6016.9 6029.5 6054.5 1591.8 1603.9 1604.0 1605.5 1614.8 1047.5 1050.7 1056.2 1092.5 1104.2 6329.2 6376.1 6379.8 6381.5 6390.3 6590.4 6654.7 6657.4 6659.9 6701.9 5685.4 5964.9 5976.8 5998.8 6046.3 3614.5 3628.2 3630.6 3634.1 3637.9 6255.7 6479.2 6491.7 6558.0 7033.4 6411.4 6421.0 6427.4 6435.9 6444.1 6306.7 6473.3 6484.7 6498.3 6551.8 6208.0 6217.3 6255.3 6299.5 6307.8 5951.9 6183.5 6197.5 6207.2 6247.7 6477.2 6535.2 6587.7 6593.4 6601.1 4425.3 4425.4 4448.9 4472.5 4478.7 6110.5 6119.4 6267.0 6282.6 6312.0 6157.0 6157.4 6173.9 6187.5 6191.4 5957.9 6114.3 6145.3 6147.4 6152.9 5909.8 5933.0 5975.5 5985.2 5988.3 6123.2 6123.5 6136.6 6185.0 6193.4 5743.7 5920.7 5922.2 5990.0 6037.3 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - PROCESS | 13125 | [#5] yui.html Cycles:180 Average:15188.42 Median:27542.17 stddev:18172.14 (66.0%) stddev-sans-first:18190.84 05:36:00 INFO - PROCESS | 13125 | Values: 764.9 841.7 843.7 877.8 907.3 13471.9 13786.2 14106.8 14167.9 14175.3 12210.2 12553.6 12600.0 12651.9 12687.1 725.4 857.8 879.1 890.3 894.3 881.5 883.7 885.3 887.0 887.3 925.9 932.4 933.8 933.9 935.7 925.2 926.5 930.8 934.1 936.2 683.7 684.0 685.7 686.0 687.6 12797.8 12882.5 12900.4 12917.7 12989.4 12750.3 12773.8 12811.4 13061.2 13255.3 10662.8 10714.6 10735.2 10804.9 11024.7 3638.5 3651.0 3664.9 3749.5 3755.5 50554.7 51072.0 56613.2 56856.0 57023.7 9470.8 9748.2 9783.9 9815.1 9969.2 18204.2 18328.4 18339.9 18341.4 18429.5 7609.1 7799.6 7890.5 8002.9 8141.4 4406.6 4418.5 4480.1 4514.2 4529.6 3306.5 3364.1 3461.2 3464.8 3476.0 649.3 649.6 651.9 654.4 657.7 798.3 799.2 804.5 818.9 850.7 9041.9 9125.6 9197.4 9354.8 9406.3 685.7 746.6 783.5 795.6 800.1 4294.7 4331.4 4423.3 4465.3 4492.3 62009.7 62092.0 63623.0 63732.4 72350.0 52145.5 54543.5 55479.0 59446.7 61685.4 55856.4 56718.7 56935.4 57218.7 57508.0 9735.0 9821.0 9898.2 9952.5 10021.9 33283.7 33919.8 34341.1 36374.5 37712.1 50770.0 50878.7 51375.5 51661.0 52517.2 12620.5 12633.2 12910.5 12929.7 12992.3 12486.7 12628.1 12808.9 12875.8 12985.7 12834.6 13113.3 13197.8 13286.3 13523.2 12570.6 12739.4 12747.8 12892.4 12949.2 12049.8 12079.6 12137.2 12319.4 12476.1 10941.7 10977.9 11078.2 11127.2 11491.3 10719.9 11145.3 11170.4 11277.7 11296.3 05:36:00 INFO - PROCESS | 13125 | -------- Summary: end -------- 05:36:00 INFO - PROCESS | 13125 | 05:36:00 INFO - TEST-INFO | 13125: exit 0 05:36:00 INFO - TEST-OK | dromaeo_css | took 1108332ms 05:36:00 INFO - TEST-START | kraken 05:36:00 INFO - operating with platform_type : linux_ 05:36:00 INFO - Initialising browser for kraken test... 05:36:00 INFO - TEST-INFO | started process 13370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUZt8Za/profile http://localhost:51006/getInfo.html) 05:36:04 INFO - PROCESS | 13370 | 05:36:04 INFO - PROCESS | 13370 | (process:13445): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:36:05 INFO - PROCESS | 13370 | __metrics Screen width/height:1600/1200 05:36:05 INFO - PROCESS | 13370 | colorDepth:24 05:36:05 INFO - PROCESS | 13370 | Browser inner width/height: 1024/697 05:36:05 INFO - PROCESS | 13370 | __metrics 05:36:05 ERROR - PROCESS | 13370 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:36:06 INFO - TEST-INFO | 13370: exit 0 05:36:06 INFO - Browser initialized. 05:36:06 INFO - Running cycle 1/1 for kraken test... 05:36:06 INFO - TEST-INFO | started process 13496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUZt8Za/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:08 INFO - PROCESS | 13496 | 05:36:08 INFO - PROCESS | 13496 | (process:13566): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:36:18 INFO - PROCESS | 13496 | RSS: Main: 152322048 05:36:18 INFO - PROCESS | 13496 | 05:36:20 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51006/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:21 INFO - PROCESS | 13496 | RSS: Main: 157155328 05:36:21 INFO - PROCESS | 13496 | 05:36:24 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51006/tests/kraken/driver.html?testName=audio-dft) 05:36:25 INFO - PROCESS | 13496 | RSS: Main: 157179904 05:36:25 INFO - PROCESS | 13496 | 05:36:27 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51006/tests/kraken/driver.html?testName=audio-fft) 05:36:28 INFO - PROCESS | 13496 | RSS: Main: 157589504 05:36:28 INFO - PROCESS | 13496 | 05:36:30 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51006/tests/kraken/driver.html?testName=audio-oscillator) 05:36:31 INFO - PROCESS | 13496 | RSS: Main: 157384704 05:36:31 INFO - PROCESS | 13496 | 05:36:33 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51006/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:34 INFO - PROCESS | 13496 | RSS: Main: 157241344 05:36:34 INFO - PROCESS | 13496 | 05:36:37 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51006/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:37 INFO - PROCESS | 13496 | RSS: Main: 157446144 05:36:37 INFO - PROCESS | 13496 | 05:36:41 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51006/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:41 INFO - PROCESS | 13496 | RSS: Main: 157863936 05:36:41 INFO - PROCESS | 13496 | 05:36:44 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51006/tests/kraken/driver.html?testName=json-parse-financial) 05:36:45 INFO - PROCESS | 13496 | RSS: Main: 157741056 05:36:45 INFO - PROCESS | 13496 | 05:36:46 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51006/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:47 INFO - PROCESS | 13496 | RSS: Main: 157511680 05:36:47 INFO - PROCESS | 13496 | 05:36:48 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:49 INFO - PROCESS | 13496 | RSS: Main: 157835264 05:36:49 INFO - PROCESS | 13496 | 05:36:51 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:52 INFO - PROCESS | 13496 | RSS: Main: 157929472 05:36:52 INFO - PROCESS | 13496 | 05:36:54 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:55 INFO - PROCESS | 13496 | RSS: Main: 158363648 05:36:55 INFO - PROCESS | 13496 | 05:36:58 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:58 INFO - PROCESS | 13496 | RSS: Main: 158531584 05:36:58 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | Cycle 1(1): loaded http://localhost:51006/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51006/tests/kraken/driver.html?testName=ai-astar) 05:37:00 INFO - PROCESS | 13496 | RSS: Main: 159969280 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | __start_tp_report 05:37:00 INFO - PROCESS | 13496 | _x_x_mozilla_page_load 05:37:00 INFO - PROCESS | 13496 | _x_x_mozilla_page_load_details 05:37:00 INFO - PROCESS | 13496 | |i|pagename|runs| 05:37:00 INFO - PROCESS | 13496 | |0;ai-astar;113;105;110;112;112;122;110;112;109;110 05:37:00 INFO - PROCESS | 13496 | |1;audio-beat-detection;153;126;160;173;138;151;153;128;179;128 05:37:00 INFO - PROCESS | 13496 | |2;audio-dft;162;163;164;162;164;164;160;162;165;162 05:37:00 INFO - PROCESS | 13496 | |3;audio-fft;76;76;77;187;76;75;73;74;163;73 05:37:00 INFO - PROCESS | 13496 | |4;audio-oscillator;92;94;151;93;91;92;147;91;91;138 05:37:00 INFO - PROCESS | 13496 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;118;117;118 05:37:00 INFO - PROCESS | 13496 | |6;imaging-darkroom;146;146;146;147;146;146;146;150;145;146 05:37:00 INFO - PROCESS | 13496 | |7;imaging-desaturate;95;95;96;95;96;95;95;97;95;96 05:37:00 INFO - PROCESS | 13496 | |8;json-parse-financial;55;58;58;56;58;57;55;82;58;61 05:37:00 INFO - PROCESS | 13496 | |9;json-stringify-tinderbox;57;57;58;57;58;59;57;57;58;58 05:37:00 INFO - PROCESS | 13496 | |10;stanford-crypto-aes;76;82;74;74;73;74;74;74;75;74 05:37:00 INFO - PROCESS | 13496 | |11;stanford-crypto-ccm;123;130;119;126;120;119;125;125;157;124 05:37:00 INFO - PROCESS | 13496 | |12;stanford-crypto-pbkdf2;160;167;165;158;161;160;164;165;168;160 05:37:00 INFO - PROCESS | 13496 | |13;stanford-crypto-sha256-iterative;69;71;74;69;75;67;67;66;66;64 05:37:00 INFO - PROCESS | 13496 | __end_tp_report 05:37:00 INFO - PROCESS | 13496 | __start_cc_report 05:37:00 INFO - PROCESS | 13496 | _x_x_mozilla_cycle_collect,862 05:37:00 INFO - PROCESS | 13496 | __end_cc_report 05:37:00 INFO - PROCESS | 13496 | __startTimestamp1462365420763__endTimestamp 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | ------- Summary: start ------- 05:37:00 INFO - PROCESS | 13496 | Number of tests: 14 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:4.33 (3.9%) stddev-sans-first:4.56 05:37:00 INFO - PROCESS | 13496 | Values: 113.0 105.0 110.0 112.0 112.0 122.0 110.0 112.0 109.0 110.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:153.00 stddev:18.75 (12.3%) stddev-sans-first:19.83 05:37:00 INFO - PROCESS | 13496 | Values: 153.0 126.0 160.0 173.0 138.0 151.0 153.0 128.0 179.0 128.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.50 stddev:1.48 (0.9%) stddev-sans-first:1.54 05:37:00 INFO - PROCESS | 13496 | Values: 162.0 163.0 164.0 162.0 164.0 164.0 160.0 162.0 165.0 162.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:42.56 (56.4%) stddev-sans-first:44.59 05:37:00 INFO - PROCESS | 13496 | Values: 76.0 76.0 77.0 187.0 76.0 75.0 73.0 74.0 163.0 73.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:91.50 stddev:25.97 (28.4%) stddev-sans-first:26.89 05:37:00 INFO - PROCESS | 13496 | Values: 92.0 94.0 151.0 93.0 91.0 92.0 147.0 91.0 91.0 138.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:37:00 INFO - PROCESS | 13496 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 05:37:00 INFO - PROCESS | 13496 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 150.0 145.0 146.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:37:00 INFO - PROCESS | 13496 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 97.0 95.0 96.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.00 stddev:8.00 (13.8%) stddev-sans-first:8.29 05:37:00 INFO - PROCESS | 13496 | Values: 55.0 58.0 58.0 56.0 58.0 57.0 55.0 82.0 58.0 61.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 05:37:00 INFO - PROCESS | 13496 | Values: 57.0 57.0 58.0 57.0 58.0 59.0 57.0 57.0 58.0 58.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.00 stddev:2.58 (3.5%) stddev-sans-first:2.71 05:37:00 INFO - PROCESS | 13496 | Values: 76.0 82.0 74.0 74.0 73.0 74.0 74.0 74.0 75.0 74.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:125.00 stddev:11.15 (8.9%) stddev-sans-first:11.74 05:37:00 INFO - PROCESS | 13496 | Values: 123.0 130.0 119.0 126.0 120.0 119.0 125.0 125.0 157.0 124.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:164.50 stddev:3.43 (2.1%) stddev-sans-first:3.48 05:37:00 INFO - PROCESS | 13496 | Values: 160.0 167.0 165.0 158.0 161.0 160.0 164.0 165.0 168.0 160.0 05:37:00 INFO - PROCESS | 13496 | 05:37:00 INFO - PROCESS | 13496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:3.58 (5.2%) stddev-sans-first:3.80 05:37:00 INFO - PROCESS | 13496 | Values: 69.0 71.0 74.0 69.0 75.0 67.0 67.0 66.0 66.0 64.0 05:37:00 INFO - PROCESS | 13496 | -------- Summary: end -------- 05:37:00 INFO - PROCESS | 13496 | 05:37:01 INFO - TEST-INFO | 13496: exit 0 05:37:01 INFO - TEST-OK | kraken | took 60781ms 05:37:01 INFO - SUITE-END | took 1169s 05:37:01 INFO - Completed test suite (00:19:29) 05:37:01 INFO - javascript benchmark 05:37:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.9169770755734, 3363.276895467474, 3378.814165220912, 3391.949120763189, 3393.9321213575745, 5578.497935185837, 5589.105743081108, 5599.440055994399, 5620.690862002588, 5627.803026894059, 5555.194496797972, 5573.247611572437, 5600.327960644729, 5606.187102870082, 5615.2700148980675, 5033.874153146173, 5093.0, 5135.178371460567, 5135.409427915782, 5152.562032227265, 5005.174146265862, 5107.719075450848, 5201.9479805201845, 5206.817761378353, 5239.476052394768, 5073.670211436263, 5134.871628209287, 5160.993606246783, 5195.142801437777, 5224.164133738603, 5120.948790512084, 5129.358830146231, 5146.305248791403, 5146.665466744649, 5183.0670479314085, 4792.281157826319, 5043.873903152414, 5047.041062198207, 5087.56755675768, 5115.0, 5316.601254905898, 5336.466353364633, 5373.973130134364, 5406.972965135188, 5407.215953686693, 5860.267466566679, 5872.0, 5880.26496687914, 5885.205497257901, 5909.290885093773, 5799.8550036249435, 5874.707564335839, 5894.204282421861, 5913.113033045035, 5935.050391937312, 5537.252470916455, 5552.555795536347, 5553.583481238923, 5559.19391688207, 5592.468715472024, 5987.880242395127, 5988.161657367972, 5994.970025149846, 5995.070764031582, 6020.819375418744, 5676.120201368794, 5707.143928410772, 5796.956547821433, 5800.216970708984, 5807.622504537191, 5920.378360272195, 5921.319048309413, 5924.733386997509, 5925.555583331267, 5946.702664866826, 5848.64908105515, 5875.676837773878, 5889.293284805851, 5902.822915312548, 5905.143754155623, 5781.248437703156, 5816.447437493432, 5923.644581325134, 5950.553708471882, 5976.641401515836, 4491.348754430589, 4512.165249428801, 4513.300438432048, 4513.435820522434, 4524.321351797257, 4055.1078762672164, 4057.918841623151, 4064.6383461540713, 4086.1214838809206, 4097.405876147942, 5532.474414930575, 5557.638753481011, 5657.830265092054, 5770.365259821417, 5803.303603567599, 5929.0513517836935, 5966.791162309299, 5967.283925928917, 5983.970080149571, 6035.849103772353, 5682.54539636828, 5694.5159661428415, 5697.401772813795, 5698.857528561819, 5703.372629010805, 4993.525615066563, 5031.371078615173, 5091.770870310845, 5101.69389836611, 5142.357205349332, 6149.538784591174, 6170.259568851677, 6171.259448866164, 6179.412955769195, 6195.473384762346, 5931.792387266425, 5937.821865344046, 5969.224000879858, 5979.282486101695, 5987.940120598825, 6012.909806352821, 6117.908231376622, 6148.1085242640465, 6162.168107305636, 6180.7527698891545, 5810.215620891126, 5844.298684157929, 5852.356240813422, 5870.383609720918, 5870.882582348415, 5963.135345374983, 5963.612365196248, 5963.73163207648, 5965.761369545343, 5972.522198224045, 5727.369989301257, 5758.8848223034465, 5762.193292939076, 5812.883742325214, 5846.883062338815, 5751.769929202785, 5783.103618939072, 5813.593048486566, 5819.76720931158, 5823.242978412779, 5685.204071430086, 5720.427957204246, 5742.19609254713, 5750.856228594319, 5757.424257574209, 5715.971420142872, 5821.068629019336, 5825.388334225015, 5887.764489420375, 5895.793647222326, 5662.745176467151, 5673.149027645886, 5707.8858422832145, 5710.428957104256, 5735.340435849764], "value": 5483.1769280125045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.8536293970916, 647.2427260105676, 656.8948968165095, 669.2504395077514, 681.1621705302481, 40205.59794402055, 41885.371719424234, 42015.369769453486, 42081.15837683244, 42162.78918605406, 41138.58861411385, 41574.37638435426, 41736.791316043455, 41870.0, 41911.79044104783, 8887.911120888773, 8999.325050621197, 9080.137386948229, 9103.36276460648, 9126.589303481325, 9000.144986226298, 9034.14175653312, 9062.546872656341, 9087.227585655228, 9124.635014599407, 9080.228180604623, 9126.087391260888, 9166.0, 9183.40307879989, 9195.494247816367, 9054.86417703735, 9119.088091190893, 9136.132067453615, 9147.359684822066, 9171.724848254564, 8895.822083558358, 9109.180173784325, 9150.49672268025, 9153.588088536031, 9203.953980230122, 31518.0, 42983.0, 43531.347029794575, 43602.563974360164, 43710.0, 3428.263193119512, 3670.7797532148156, 3697.9815100924593, 4014.5383280922483, 4381.364702118175, 29497.557536636967, 29932.102036938926, 29944.550831737542, 30042.24894377636, 31125.0, 4447.466304043503, 4451.688381813275, 4485.349624304457, 4516.774161291923, 4615.699979501322, 254383.0, 257501.0, 258247.9999999981, 258987.0, 260642.69678651675, 36689.633103668624, 37251.0, 37409.0, 37568.62431375651, 38571.80714096411, 37640.43539346912, 37655.24689506249, 38078.42882356767, 38154.42768358477, 38242.0, 17426.21582028812, 17564.736528952075, 17593.208305626278, 17604.119794010505, 17613.119344033003, 14221.14673119616, 14331.0, 14349.78475322871, 14373.99382043247, 14517.201553914636, 9503.619855205714, 9559.394990135614, 9631.951840240894, 9638.807223855483, 9690.70927872165, 3553.857845686195, 3615.439606860941, 3644.1982763791925, 3674.6141655125825, 3692.1508053147927, 1043.0299821166388, 1147.6671765188169, 1160.5357856857324, 1183.3964678014274, 1185.3184418959133, 33053.0, 33614.15964600856, 33715.325693486, 33925.0, 34003.0, 1199.7780410623889, 1200.0819373179525, 1214.5688280660415, 1229.8339724137127, 1266.860645329013, 17850.464486065437, 17948.37180698669, 18065.54836129081, 18089.185986630633, 18299.451016469528, 331431.0, 342724.0, 348951.0, 499362.0, 510564.0, 60936.39063609396, 62250.0, 62445.0, 62502.0, 62691.686541567, 796.7530065679658, 1344.3211178354868, 1517.5068102866612, 1529.4341093795144, 1530.833870073833, 33617.495737564444, 33746.66253337435, 34274.485882711284, 34501.827490862386, 34577.654223457444, 55811.72094139503, 56988.145177821534, 57066.42933570611, 57147.714261428424, 57271.42728572661, 483976.0, 486559.0, 486861.0, 487994.0, 489259.0, 31243.84378078095, 31390.215244619067, 31644.367112657157, 31754.206144846565, 31970.52044219385, 51154.0, 51370.486295138064, 51397.74301128471, 51913.74043129911, 52037.21944170916, 43280.134397312504, 43435.56564434315, 43661.56338436702, 43738.56261437345, 45231.095378091595, 38553.614463855, 42719.786401067795, 43059.0, 43112.35331469968, 43588.56411435972, 40306.1938761229, 40884.18231635291, 41062.0, 41226.58773412227, 41326.79336603298, 35535.28929421346, 37276.813615931744, 37421.25157496889, 37675.62324376831, 38485.0, 29524.261893452836, 29758.404831903674, 29948.0, 29950.850245748632, 30341.241468963453], "value": 19283.29064229225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.26339689384815, 435.1167130724629, 437.6476687037055, 443.45455090239005, 449.86504048785355, 18783.906080469595, 19310.227590896364, 19367.515812104688, 21156.25953091642, 21252.0, 19224.846509209423, 19651.705224421647, 20197.293094741686, 20335.796642033576, 20459.48851278719, 5836.6789826559625, 5998.0, 6004.0, 6009.06859436788, 6035.853187894308, 5709.514691251248, 5901.557383196277, 5964.433378829004, 5967.791127310545, 5975.25309336333, 5777.480026797587, 5806.564507661921, 5894.263217097863, 5894.4989675877605, 5899.495628614719, 5769.509591684712, 5775.711214439261, 5913.615614985012, 5946.316173640043, 5953.404659534055, 5245.659032162897, 5304.336957880265, 5311.521963023347, 5315.867103322409, 5371.274877891474, 23205.88397058021, 23387.305828630775, 23542.17602383908, 23798.405039873967, 24196.758032419628, 2513.899444022237, 2582.2769624505167, 2612.3991481959256, 2912.7087291270705, 2958.6301712285963, 14776.778348324784, 15066.322015509219, 15092.471763488335, 15123.470678526199, 15273.923630381776, 1948.298612499499, 2048.365006847867, 2074.968875466869, 2103.1377135374423, 2148.581026699794, 86733.0, 88305.55847220786, 88630.556847216, 90112.0, 91243.54378228133, 11173.268143437781, 11387.918147775948, 11539.596114135966, 11586.246893951866, 11733.237339572901, 16245.0, 16321.83678163227, 16404.09777462227, 16411.1794410279, 16435.424760133337, 8895.154960278764, 8987.19115279628, 9130.589123489459, 9138.451692898447, 9178.705323669083, 8989.190972812348, 9001.684941027033, 9042.547872606343, 9198.98811130775, 9230.07699230085, 6921.861562768817, 7099.325564071405, 7183.353498185188, 7188.0, 7263.927360726325, 1993.880367177974, 2058.475088852333, 2076.3874656976227, 2083.895805209733, 2102.432343267309, 944.9196818270524, 1040.599369242847, 1079.1312993040679, 1106.446776611694, 1121.103117505992, 19766.50583735418, 19790.70313945292, 20074.79925200729, 20183.59632807365, 20373.694394584094, 1070.7644318249972, 1085.495244711213, 1086.3916206924148, 1119.339589642115, 1136.6249137784512, 11341.603043893425, 11614.6515604532, 11687.415629218505, 11771.646850594496, 11776.705582360339, 507014.0, 512397.0, 543902.0, 551622.0, 552824.0, 104726.4763676192, 105413.47293263485, 107315.46342268396, 108031.45984270185, 109966.0, 1057.8201705709894, 1073.4203530093819, 1098.6045023791428, 1116.4417791104286, 1118.3960661243, 16832.07423591714, 16969.32122715127, 17890.642187155925, 17945.910270448563, 18199.0, 41346.79326603348, 41507.37738933979, 42182.578174217866, 43140.0, 43341.3498797512, 58237.12644310254, 59991.70004150126, 60167.39832601618, 60661.0, 60757.69621151866, 8648.30813534903, 8989.235914947303, 9141.405808622418, 9186.632534698805, 9250.907490925005, 13259.337033148497, 13861.346831422517, 14489.782653260421, 14534.345954431865, 14781.0, 11857.5849845255, 12387.69030774238, 12455.501779928702, 12658.936705316415, 12723.80914286268, 7913.920860791319, 10154.035366640157, 12337.136400451882, 12625.675466652134, 13247.801282980956, 12685.302308373128, 12848.486060557472, 12877.162984405984, 12946.0, 13017.934910325388, 9377.343585948918, 9410.435373877315, 9419.670311539063, 9445.669401570913, 9569.952150239204, 12600.495980160691, 12993.870061299265, 13078.607641770763, 13148.934255329044, 13220.933895330461], "value": 9995.313620241785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.617158796095, 1579.510351790945, 1835.5227640813384, 1898.4399602117373, 1928.373278684428, 8094.190580941903, 8429.91570084299, 8576.14238576142, 8737.951445826502, 8751.693690720818, 8644.092370301121, 8663.306935445165, 8670.826583468326, 8677.219050285488, 8736.0, 2347.5187586544803, 2365.1012615206196, 2366.8461549999283, 2373.6320870265135, 2383.5113801670705, 2395.4849707312924, 2412.9034838606435, 2448.461338505526, 2452.3746444656585, 2456.103522214397, 2433.2578563538113, 2434.075051480435, 2454.1533171055958, 2456.5823809952353, 2467.5064987002584, 2383.1420688552193, 2383.511380167062, 2391.5814732421754, 2395.47299594089, 2430.1008626808016, 2366.479374537616, 2374.014783864694, 2378.63131214662, 2383.6067048936907, 2400.4238982644038, 8884.978227503856, 8928.776780580472, 8945.284377249804, 8946.373753837233, 8958.776030599221, 5106.387233531963, 5247.658902171346, 5258.973705131488, 5264.026155161269, 5293.285406470116, 3333.96666033339, 3350.1792060945227, 3414.334204830034, 3467.4452087666104, 3469.4795780632853, 1137.590467431724, 1138.7494751154732, 1148.5004023249912, 1163.3834067944003, 1181.3856794466915, 11155.609553665663, 11159.107271418266, 11191.888081119167, 11224.32654040752, 11331.716707082307, 4587.655925805578, 4655.813767449332, 4657.790399432034, 4689.1559519286175, 4751.928721069186, 9669.081437263589, 9678.95160524193, 9691.07934746198, 9695.078967498077, 9724.70825875225, 5163.793448262102, 5227.817026404134, 5264.184051472028, 5301.469853014745, 5343.70609616467, 4580.908381832344, 4767.070421267889, 4795.256735206049, 4804.5195480451675, 4897.510248975074, 4078.775667338325, 4158.91682166355, 4256.0, 4257.0, 4273.658107351404, 1308.8691130887025, 1311.967200819987, 1322.107577385261, 1323.9867601324056, 1336.3986206207246, 1038.3977293169944, 1052.5316234275826, 1053.5838343854134, 1057.836035414512, 1064.2443864855884, 5931.3178984417345, 5975.163477113208, 6030.517558595302, 6119.5410344224365, 6146.692665366714, 455.04213630308385, 459.4165409929371, 473.96919200251875, 476.12155572967816, 482.6597248939489, 4117.3618089196225, 4183.414321994923, 4222.408862759216, 4248.192843359751, 4284.357346398003, 10590.523426445674, 11116.110711143088, 11125.666230013112, 11251.718707032389, 11275.436228188722, 11027.44862756859, 11104.222704410775, 11121.110311175087, 11127.443627818577, 11129.944350278196, 8218.465799722999, 8385.790355241168, 8388.622511986976, 8467.364947628952, 8559.058503564604, 5915.438033386821, 6055.061465472859, 6064.727087280995, 6135.662538560422, 6180.47465965398, 10081.546330415296, 10224.13094886943, 10254.128399085863, 10305.74235644115, 10504.947475262576, 10296.227782916161, 10505.264631475724, 10511.526981285708, 10512.789744205225, 10554.10290125348, 7245.891311630435, 7612.7716168515035, 7888.605569721376, 7968.601569921597, 8071.717489887826, 8393.95803020981, 8428.199321064489, 8496.06543280251, 8524.27543658796, 8536.402451828313, 7574.204708505527, 7884.881726774218, 8051.637676304464, 8076.192380761877, 8280.50316980983, 8009.359251260002, 8049.315808156372, 8110.716124935599, 8158.877616835871, 8163.020437547532, 7131.500794944304, 7348.191698913222, 7378.778636640909, 7470.626468676436, 7472.140703818913, 5468.617196796186, 5479.698616575967, 5507.586930980273, 5518.641288316247, 5596.3284405871555, 5534.833954981196, 5602.4957753802355, 5603.551715862803, 5633.0705433603, 5710.8001219957105], "value": 4656.491663892232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8838783201544, 359.0735901374454, 365.90120667419797, 370.616412013566, 371.5392912788142, 5634.859128521789, 5674.602777805555, 5719.14212868069, 5806.216160818293, 5806.883862322757, 5645.887082258352, 5700.230468886699, 5703.800366987156, 5726.541876649869, 5753.482186603205, 4417.3815665806815, 4465.620422264095, 4474.194644963905, 4476.462824461069, 4497.280435130379, 4409.5149533551285, 4410.9779451102695, 4482.574155455227, 4487.214737420938, 4496.213162696515, 4442.466903971528, 4453.888652783674, 4454.57681520255, 4459.710118842281, 4468.50846406895, 4469.435697505864, 4471.195184866723, 4482.439695038121, 4488.281874900033, 4523.819047238107, 3698.1863989922176, 3891.299566078105, 3999.900002499932, 4000.4599379084034, 4001.8199181036925, 5413.945860541384, 5501.834944951618, 5508.944910550923, 5509.256250406224, 5509.622594351412, 5030.421501527335, 5077.26379674945, 5080.923786143211, 5089.287499750038, 5102.795888164469, 5704.258446401941, 5928.229330187048, 5944.176516154836, 5945.346011938684, 5976.850578735566, 4278.893027674302, 4287.699861009731, 4292.527821939584, 4293.819199720071, 4313.611774940239, 6147.569670123048, 6258.655773932432, 6260.812175634738, 6269.87460250797, 6320.273168585625, 4259.382389553497, 4261.296886013773, 4342.5657434256955, 4346.978265108654, 4357.150355680612, 4402.647788176938, 4406.449193850769, 4443.311286750559, 4445.355423463579, 4464.955350446454, 5080.288759573663, 5092.6435149539175, 5094.286799848024, 5102.158143906214, 5104.0, 5842.795502157404, 5856.150858125633, 6016.909746353808, 6029.517638588903, 6054.455099041107, 1591.7930669012953, 1603.8877278590387, 1603.9679206415806, 1605.5183444966463, 1614.7577863320362, 1047.486731501574, 1050.726811029138, 1056.1761825775907, 1092.5192915117323, 1104.1884215101893, 6329.208848893888, 6376.107344971708, 6379.840503987344, 6381.489480841522, 6390.297067322591, 6590.439812615886, 6654.700538475683, 6657.434118100015, 6659.9001014984815, 6701.932980670228, 5685.403032681592, 5964.8807023860145, 5976.820695379146, 5998.820035398945, 6046.304674962347, 3614.4578313253223, 3628.2017956049626, 3630.636936306348, 3634.1459756957092, 3637.872674456434, 6255.6872156392, 6479.1901012373455, 6491.747905122153, 6557.967210163919, 7033.437325013987, 6411.3909178627955, 6420.967895160495, 6427.389398007182, 6435.942927109585, 6444.130042444303, 6306.653134077578, 6473.255575608771, 6484.675766211576, 6498.277956341573, 6551.80344589663, 6208.0, 6217.285012223652, 6255.311915689362, 6299.496040316672, 6307.842303942438, 5951.851203719769, 6183.505319574333, 6197.5351848610635, 6207.16203312547, 6247.6563788990225, 6477.190351206099, 6535.150430444012, 6587.715395497832, 6593.3736295051895, 6601.141851559267, 4425.3140763181755, 4425.446819147606, 4448.866534003985, 4472.508024117409, 4478.731276123443, 6110.450059494667, 6119.388061193845, 6267.0, 6282.591631544118, 6312.0, 6157.029750479804, 6157.384261573807, 6173.938260617337, 6187.535934804818, 6191.4118158774845, 5957.940420595912, 6114.296855861455, 6145.262568491809, 6147.385261473817, 6152.907706384497, 5909.8227053188475, 5933.033483258371, 5975.521958243417, 5985.221921150222, 5988.251468566429, 6123.173371594956, 6123.510119190543, 6136.637394603021, 6185.010398336424, 6193.4425901669065, 5743.712814359182, 5920.703964801829, 5922.200502932049, 5990.023292313439, 6037.335893051673], "value": 4661.255874908513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.8929149919011, 841.688575227166, 843.6878355008648, 877.8024944387514, 907.2696479334141, 13471.865281347184, 13786.172829630217, 14106.78839817401, 14167.85832141677, 14175.291235438213, 12210.206336588115, 12553.560625378113, 12600.0, 12651.936740316309, 12687.111902166853, 725.365305357812, 857.8241460500583, 879.1296616349799, 890.3411475508142, 894.2577660541767, 881.5460038080394, 883.6818745251704, 885.313881741649, 887.0, 887.3344991256557, 925.8842644669417, 932.39394393644, 933.8179055084262, 933.869258303838, 935.6818681648239, 925.1673493855517, 926.536731634183, 930.7533503621546, 934.1359242700509, 936.2322895225883, 683.7094234950126, 684.0218487562784, 685.7120009595932, 685.9759908403232, 687.60806340386, 12797.808032879515, 12882.549110781078, 12900.419481123372, 12917.67705807353, 12989.350532473432, 12750.29873356965, 12773.808392874114, 12811.423485943154, 13061.21632702041, 13255.337233138402, 10662.840057399146, 10714.571417143305, 10735.248532602722, 10804.945975270151, 11024.669259922215, 3638.5088013118157, 3651.0, 3664.926701465982, 3749.512563366745, 3755.455458958436, 50554.74722626364, 51072.0, 56613.15080273758, 56856.0, 57023.714881425745, 9470.763230919281, 9748.220142388593, 9783.902160978441, 9815.11663950248, 9969.152622027208, 18204.180811863498, 18328.358507452176, 18339.908300458414, 18341.358052468368, 18429.53926151857, 7609.086909570776, 7799.649015794303, 7890.526568405914, 8002.8799568006525, 8141.389395795339, 4406.5593440655675, 4418.513963464016, 4480.14877173336, 4514.187446259639, 4529.592336689714, 3306.454435018195, 3364.091695242271, 3461.1693193633346, 3464.7921124732093, 3476.0, 649.3311888754496, 649.561545956487, 651.8500744828716, 654.3685343643407, 657.7336178847575, 798.253632853284, 799.2407213147533, 804.5454318310253, 818.9385796065319, 850.6597361055503, 9041.909580904106, 9125.634974601075, 9197.356185066981, 9354.812903741888, 9406.341556091007, 685.7497013590004, 746.6490749347798, 783.5298820707529, 795.6379847169524, 800.087899794235, 4294.677899157513, 4331.393604895317, 4423.270160423494, 4465.330200469955, 4492.258777301774, 62009.68995154995, 62092.0, 63623.0, 63732.36267637357, 72350.0, 52145.47854521482, 54543.45456545463, 55479.0, 59446.70276648589, 61685.383146167966, 55856.44143558593, 56718.71640641853, 56935.43064569384, 57218.71390643103, 57508.0, 9735.0, 9820.950895245478, 9898.208143348658, 9952.502374881371, 10021.899781002388, 33283.66716332806, 33919.83040084784, 34341.141471463416, 36374.45438318374, 37712.057198570255, 50770.0, 50878.74560627173, 51375.48624513707, 51661.0, 52517.21224181717, 12620.495180192689, 12633.2420054797, 12910.483580656668, 12929.741405172032, 12992.285424301754, 12486.687832804253, 12628.116031878048, 12808.871911280768, 12875.806862896876, 12985.675358116123, 12834.55079072228, 13113.278769667379, 13197.80203296932, 13286.335683215608, 13523.188608683511, 12570.560030398892, 12739.363031848556, 12747.808782868078, 12892.355382231039, 12949.158304710163, 12049.819252711392, 12079.637610871689, 12137.150399471951, 12319.44562494672, 12476.06429517808, 10941.726456838644, 10977.945110274397, 11078.224524283223, 11127.221094523306, 11491.310521368745, 10719.946400267949, 11145.331280123219, 11170.441477925908, 11277.661670149908, 11296.265742726697], "value": 6866.596813903869, "unit": "score"}], "name": "dromaeo_css", "value": 7348.954716627273, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 112.0, 112.0, 122.0, 110.0, 112.0, 109.0, 110.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 160.0, 173.0, 138.0, 151.0, 153.0, 128.0, 179.0, 128.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 162.0, 164.0, 164.0, 160.0, 162.0, 165.0, 162.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 187.0, 76.0, 75.0, 73.0, 74.0, 163.0, 73.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 151.0, 93.0, 91.0, 92.0, 147.0, 91.0, 91.0, 138.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 150.0, 145.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 58.0, 56.0, 58.0, 57.0, 55.0, 82.0, 58.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 57.0, 58.0, 59.0, 57.0, 57.0, 58.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 74.0, 74.0, 73.0, 74.0, 74.0, 74.0, 75.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 119.0, 126.0, 120.0, 119.0, 125.0, 125.0, 157.0, 124.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 167.0, 165.0, 158.0, 161.0, 160.0, 164.0, 165.0, 168.0, 160.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 74.0, 69.0, 75.0, 67.0, 67.0, 66.0, 66.0, 64.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1536.2999999999997, "alertThreshold": 2.0}]} 05:37:02 INFO - Return code: 0 05:37:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:37:02 ERROR - # TBPL SUCCESS # 05:37:02 INFO - Running post-action listener: _resource_record_post_action 05:37:02 INFO - Running post-run listener: _resource_record_post_run 05:37:03 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 139264; Write bytes: 323952640; Read time: 16; Write time: 201564 05:37:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 76713984; Read time: 0; Write time: 64936 05:37:03 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 139264; Write bytes: 247238656; Read time: 16; Write time: 136628 05:37:03 INFO - Running post-run listener: _upload_blobber_files 05:37:03 INFO - Blob upload gear active. 05:37:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:04 INFO - (blobuploader) - INFO - Done attempting. 05:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:04 INFO - (blobuploader) - INFO - Done attempting. 05:37:04 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:04 INFO - Return code: 0 05:37:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e8116a3dce5d1d87a0de2e66d94663ae932dadd91e481bf36d1e16a89205c7a05e7ea520a748c0b64f629c58d2b6d364cd4632dbc86f83151e7b93fce923116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7010c72a0389ad9e2dbf8765eb5e0bee701a11a35818ed7be2382b7e41ddbf19f357307f10c83f95cec6528f2c7aee83e930b5de796230ea68b201468dc2b597"} 05:37:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:04 INFO - Contents: 05:37:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e8116a3dce5d1d87a0de2e66d94663ae932dadd91e481bf36d1e16a89205c7a05e7ea520a748c0b64f629c58d2b6d364cd4632dbc86f83151e7b93fce923116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7010c72a0389ad9e2dbf8765eb5e0bee701a11a35818ed7be2382b7e41ddbf19f357307f10c83f95cec6528f2c7aee83e930b5de796230ea68b201468dc2b597"} 05:37:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:04 INFO - Copying logs to upload dir... 05:37:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2124.487053 ========= master_lag: 8.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 33 secs) (at 2016-05-04 05:37:13.544319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 16 secs) (at 2016-05-04 05:37:13.549238) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e8116a3dce5d1d87a0de2e66d94663ae932dadd91e481bf36d1e16a89205c7a05e7ea520a748c0b64f629c58d2b6d364cd4632dbc86f83151e7b93fce923116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7010c72a0389ad9e2dbf8765eb5e0bee701a11a35818ed7be2382b7e41ddbf19f357307f10c83f95cec6528f2c7aee83e930b5de796230ea68b201468dc2b597"} build_url:https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/S7rVUVb_Rd-HdT7xvLQl6Q/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e8116a3dce5d1d87a0de2e66d94663ae932dadd91e481bf36d1e16a89205c7a05e7ea520a748c0b64f629c58d2b6d364cd4632dbc86f83151e7b93fce923116", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7010c72a0389ad9e2dbf8765eb5e0bee701a11a35818ed7be2382b7e41ddbf19f357307f10c83f95cec6528f2c7aee83e930b5de796230ea68b201468dc2b597"}' ========= master_lag: 16.88 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 16 secs) (at 2016-05-04 05:37:30.436633) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:37:30.436966) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462363213.80018-1646108973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004123 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 05:37:30.454169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 05:37:30.454720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 05:37:30.456808) ========= ========= Total master_lag: 25.66 =========