builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1476380713.38 results: success (0) buildid: 20161013094723 builduid: 0da20c8661f44af2817d36ba298c6937 revision: 7452437b3ab571b1d60aed4e973d82a1471f72b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.378229) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.378727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.379059) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.390872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.391244) ========= 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=523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 10:45:13-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-10-13 10:45:13 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115986 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.518623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.518974) ========= 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=523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015881 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.568193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:13.568555) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7452437b3ab571b1d60aed4e973d82a1471f72b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7452437b3ab571b1d60aed4e973d82a1471f72b2 --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=523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 10:45:14,039 truncating revision to first 12 chars 2016-10-13 10:45:14,039 Setting DEBUG logging. 2016-10-13 10:45:14,039 attempt 1/10 2016-10-13 10:45:14,039 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7452437b3ab5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 10:45:14,363 unpacking tar archive at: mozilla-central-7452437b3ab5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:14.275471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:14.275876) ========= script_repo_revision: 7452437b3ab571b1d60aed4e973d82a1471f72b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:14.276453) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:14.276738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 10:45:14.286394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-13 10:45:14.286809) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:45:14 INFO - MultiFileLogger online at 20161013 10:45:14 in /builds/slave/test 10:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:45:14 INFO - {'append_to_log': False, 10:45:14 INFO - 'base_work_dir': '/builds/slave/test', 10:45:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:45:14 INFO - 'branch': 'Firefox-Non-PGO', 10:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:45:14 INFO - 'config_files': ('talos/linux_config.py',), 10:45:14 INFO - 'default_actions': ('clobber', 10:45:14 INFO - 'read-buildbot-config', 10:45:14 INFO - 'download-and-extract', 10:45:14 INFO - 'populate-webroot', 10:45:14 INFO - 'create-virtualenv', 10:45:14 INFO - 'install', 10:45:14 INFO - 'run-tests'), 10:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:45:14 INFO - 'download_minidump_stackwalk': True, 10:45:14 INFO - 'download_symbols': 'ondemand', 10:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:45:14 INFO - 'installer_path': 'installer.exe', 10:45:14 INFO - 'log_level': 'info', 10:45:14 INFO - 'log_name': 'talos', 10:45:14 INFO - 'log_to_console': True, 10:45:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:45:14 INFO - 'opt_config_files': (), 10:45:14 INFO - 'pip_index': False, 10:45:14 INFO - 'sps_profile': False, 10:45:14 INFO - 'sps_profile_interval': 0, 10:45:14 INFO - 'suite': 'dromaeojs', 10:45:14 INFO - 'system_bits': '32', 10:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:45:14 INFO - 'title': 'talos-linux64-ix-065', 10:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:45:14 INFO - 'use_talos_json': True, 10:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:45:14 INFO - 'work_dir': 'build'} 10:45:14 INFO - [mozharness: 2016-10-13 17:45:14.846499Z] Running clobber step. 10:45:14 INFO - Running pre-action listener: _resource_record_pre_action 10:45:14 INFO - Running main action method: clobber 10:45:14 INFO - rmtree: /builds/slave/test/build 10:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:45:15 INFO - Running post-action listener: _resource_record_post_action 10:45:15 INFO - [mozharness: 2016-10-13 17:45:15.878414Z] Finished clobber step (success) 10:45:15 INFO - [mozharness: 2016-10-13 17:45:15.878514Z] Running read-buildbot-config step. 10:45:15 INFO - Running pre-action listener: _resource_record_pre_action 10:45:15 INFO - Running main action method: read_buildbot_config 10:45:15 INFO - Using buildbot properties: 10:45:15 INFO - { 10:45:15 INFO - "project": "", 10:45:15 INFO - "product": "firefox", 10:45:15 INFO - "script_repo_revision": "production", 10:45:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:45:15 INFO - "repository": "", 10:45:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:45:15 INFO - "buildid": "20161013094723", 10:45:15 INFO - "pgo_build": "False", 10:45:15 INFO - "basedir": "/builds/slave/test", 10:45:15 INFO - "buildnumber": 249, 10:45:15 INFO - "slavename": "talos-linux64-ix-065", 10:45:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:45:15 INFO - "platform": "ubuntu64_hw", 10:45:15 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:45:15 INFO - "branch": "mozilla-central", 10:45:15 INFO - "repo_path": "mozilla-central", 10:45:15 INFO - "revision": "7452437b3ab571b1d60aed4e973d82a1471f72b2", 10:45:15 INFO - "stage_platform": "linux64", 10:45:15 INFO - "builduid": "0da20c8661f44af2817d36ba298c6937", 10:45:15 INFO - "slavebuilddir": "test" 10:45:15 INFO - } 10:45:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:45:15 INFO - Running post-action listener: _resource_record_post_action 10:45:15 INFO - [mozharness: 2016-10-13 17:45:15.880929Z] Finished read-buildbot-config step (success) 10:45:15 INFO - [mozharness: 2016-10-13 17:45:15.881017Z] Running download-and-extract step. 10:45:15 INFO - Running pre-action listener: _resource_record_pre_action 10:45:15 INFO - Running main action method: download_and_extract 10:45:15 INFO - mkdir: /builds/slave/test/build/tests 10:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:15 INFO - trying https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:45:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:45:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:45:16 INFO - Downloaded 1361 bytes. 10:45:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:45:16 INFO - Using the following test package requirements: 10:45:16 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:45:16 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:45:16 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:45:16 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'jsshell-linux-x86_64.zip'], 10:45:16 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:45:16 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:45:16 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:45:16 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:45:16 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:45:16 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:45:16 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:45:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:45:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:45:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:45:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:45:17 INFO - Http code: 200 10:45:17 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:45:17 INFO - x-amz-cf-id: 8Ao7w-wWIjWs6s_6Z7pY8KeQ7v8teuvitUKQU8nl8aSIRqmoYdB-8g== 10:45:17 INFO - x-amz-version-id: l4rEQR0Qnn8nmuSsdcs7CK3uVlfSEwaM 10:45:17 INFO - Expected file size: 20551129 10:45:17 INFO - Obtained file size: 20551129 10:45:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:45:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:45:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:45:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:45:21 INFO - Http code: 200 10:45:21 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 10:45:21 INFO - x-amz-cf-id: JNkZUSrCkEp2wJiUqRkjSYHVpxtjqJNdahZTkRsl0-xu8U19qq1IpA== 10:45:21 INFO - x-amz-version-id: l4rEQR0Qnn8nmuSsdcs7CK3uVlfSEwaM 10:45:22 INFO - Expected file size: 20551129 10:45:22 INFO - Obtained file size: 20551129 10:45:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:45:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:45:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:45:27 INFO - Http code: 200 10:45:27 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 10:45:27 INFO - x-amz-cf-id: -zWevemShE9hUR3Fqxlx87Xb1w4A6ctpsSHbShYygGFz-olk3_1LtQ== 10:45:27 INFO - x-amz-version-id: mABQZvFxQpnefG9MuCmSB.wgRfAKDWuK 10:45:28 INFO - Expected file size: 14409006 10:45:28 INFO - Obtained file size: 14409006 10:45:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:28 INFO - trying https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:45:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:45:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:45:29 INFO - Downloaded 55928535 bytes. 10:45:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:45:29 INFO - mkdir: /builds/slave/test/properties 10:45:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:45:29 INFO - Writing to file /builds/slave/test/properties/build_url 10:45:29 INFO - Contents: 10:45:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:45:30 INFO - Running post-action listener: _resource_record_post_action 10:45:30 INFO - Running post-action listener: set_extra_try_arguments 10:45:30 INFO - [mozharness: 2016-10-13 17:45:30.342057Z] Finished download-and-extract step (success) 10:45:30 INFO - [mozharness: 2016-10-13 17:45:30.342471Z] Running populate-webroot step. 10:45:30 INFO - Running pre-action listener: _resource_record_pre_action 10:45:30 INFO - Running main action method: populate_webroot 10:45:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:45:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:45:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:45:30 INFO - '--tppagecycles', 10:45:30 INFO - '7'], 10:45:30 INFO - 'tests': ['tsvgm']}}, 10:45:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:45:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:45:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:45:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:45:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:45:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['damp', 'tps']}, 10:45:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'tests': ['damp', 'tps']}, 10:45:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['dromaeo_dom']}, 10:45:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:45:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['basic_compositor_video']}, 10:45:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:45:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['a11yr', 10:45:30 INFO - 'ts_paint', 10:45:30 INFO - 'tpaint', 10:45:30 INFO - 'sessionrestore', 10:45:30 INFO - 'sessionrestore_no_auto_restore', 10:45:30 INFO - 'tabpaint']}, 10:45:30 INFO - 'other-e10s': {'tests': ['a11yr', 10:45:30 INFO - 'ts_paint', 10:45:30 INFO - 'tpaint', 10:45:30 INFO - 'sessionrestore', 10:45:30 INFO - 'sessionrestore_no_auto_restore', 10:45:30 INFO - 'tabpaint']}, 10:45:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:45:30 INFO - 'ts_paint', 10:45:30 INFO - 'tpaint', 10:45:30 INFO - 'sessionrestore', 10:45:30 INFO - 'sessionrestore_no_auto_restore', 10:45:30 INFO - 'tabpaint']}, 10:45:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:45:30 INFO - 'ts_paint', 10:45:30 INFO - 'tpaint', 10:45:30 INFO - 'sessionrestore', 10:45:30 INFO - 'sessionrestore_no_auto_restore', 10:45:30 INFO - 'tabpaint']}, 10:45:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['a11yr', 10:45:30 INFO - 'ts_paint', 10:45:30 INFO - 'tpaint', 10:45:30 INFO - 'sessionrestore', 10:45:30 INFO - 'sessionrestore_no_auto_restore', 10:45:30 INFO - 'tabpaint']}, 10:45:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['a11yr', 10:45:30 INFO - 'ts_paint', 10:45:30 INFO - 'tpaint', 10:45:30 INFO - 'sessionrestore', 10:45:30 INFO - 'sessionrestore_no_auto_restore', 10:45:30 INFO - 'tabpaint']}, 10:45:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['tsvgx', 10:45:30 INFO - 'tsvgr_opacity', 10:45:30 INFO - 'tart', 10:45:30 INFO - 'tscrollx', 10:45:30 INFO - 'cart']}, 10:45:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:45:30 INFO - 'tsvgr_opacity', 10:45:30 INFO - 'tart', 10:45:30 INFO - 'tscrollx', 10:45:30 INFO - 'cart']}, 10:45:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'talos_options': ['--disable-e10s'], 10:45:30 INFO - 'tests': ['tp5o']}, 10:45:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'tests': ['tp5o']}, 10:45:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'talos_options': ['--disable-e10s', 10:45:30 INFO - '--xperf_path', 10:45:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:30 INFO - 'tests': ['tp5n']}, 10:45:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:45:30 INFO - 'talos_options': ['--xperf_path', 10:45:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:45:30 INFO - 'tests': ['tp5n']}}, 10:45:30 INFO - 'talos.zip': {'path': '', 10:45:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:45:30 INFO - Running post-action listener: _resource_record_post_action 10:45:30 INFO - [mozharness: 2016-10-13 17:45:30.364486Z] Finished populate-webroot step (success) 10:45:30 INFO - [mozharness: 2016-10-13 17:45:30.364577Z] Running create-virtualenv step. 10:45:30 INFO - Running pre-action listener: _resource_record_pre_action 10:45:30 INFO - Running main action method: create_virtualenv 10:45:30 INFO - Creating virtualenv /builds/slave/test/build/venv 10:45:30 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 10:45:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:45:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:45:30 INFO - Using real prefix '/usr' 10:45:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:45:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:45:32 INFO - Installing pip.................done. 10:45:32 INFO - Return code: 0 10:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:45:33 INFO - Reading from file tmpfile_stdout 10:45:33 INFO - Output received: 10:45:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:45:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:45:33 INFO - Using env: {'DISPLAY': ':0', 10:45:33 INFO - 'HOME': '/home/cltbld', 10:45:33 INFO - 'LANG': 'en_US.UTF-8', 10:45:33 INFO - 'LANGUAGE': 'en_US:en', 10:45:33 INFO - 'LOGNAME': 'cltbld', 10:45:33 INFO - 'MAIL': '/var/mail/cltbld', 10:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:33 INFO - 'MOZ_NO_REMOTE': '1', 10:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:33 INFO - 'NO_EM_RESTART': '1', 10:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:33 INFO - 'PWD': '/builds/slave/test', 10:45:33 INFO - 'SHELL': '/bin/bash', 10:45:33 INFO - 'SHLVL': '1', 10:45:33 INFO - 'TERM': 'linux', 10:45:33 INFO - 'TMOUT': '86400', 10:45:33 INFO - 'USER': 'cltbld', 10:45:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:33 INFO - '_': '/tools/buildbot/bin/python'} 10:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:33 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 10:45:33 INFO - Cleaning up... 10:45:33 INFO - Return code: 0 10:45:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:45:33 INFO - Using env: {'DISPLAY': ':0', 10:45:33 INFO - 'HOME': '/home/cltbld', 10:45:33 INFO - 'LANG': 'en_US.UTF-8', 10:45:33 INFO - 'LANGUAGE': 'en_US:en', 10:45:33 INFO - 'LOGNAME': 'cltbld', 10:45:33 INFO - 'MAIL': '/var/mail/cltbld', 10:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:33 INFO - 'MOZ_NO_REMOTE': '1', 10:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:33 INFO - 'NO_EM_RESTART': '1', 10:45:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:33 INFO - 'PWD': '/builds/slave/test', 10:45:33 INFO - 'SHELL': '/bin/bash', 10:45:33 INFO - 'SHLVL': '1', 10:45:33 INFO - 'TERM': 'linux', 10:45:33 INFO - 'TMOUT': '86400', 10:45:33 INFO - 'USER': 'cltbld', 10:45:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:33 INFO - '_': '/tools/buildbot/bin/python'} 10:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:33 INFO - Downloading/unpacking psutil>=3.1.1 10:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:45:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:35 INFO - Installing collected packages: psutil 10:45:35 INFO - Running setup.py install for psutil 10:45:35 INFO - building 'psutil._psutil_linux' extension 10:45:35 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 10:45:35 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 10:45:36 INFO - building 'psutil._psutil_posix' extension 10:45:36 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 10:45:36 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 10:45:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:45:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:45:36 INFO - Successfully installed psutil 10:45:36 INFO - Cleaning up... 10:45:36 INFO - Return code: 0 10:45:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:45:36 INFO - Using env: {'DISPLAY': ':0', 10:45:36 INFO - 'HOME': '/home/cltbld', 10:45:36 INFO - 'LANG': 'en_US.UTF-8', 10:45:36 INFO - 'LANGUAGE': 'en_US:en', 10:45:36 INFO - 'LOGNAME': 'cltbld', 10:45:36 INFO - 'MAIL': '/var/mail/cltbld', 10:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:36 INFO - 'MOZ_NO_REMOTE': '1', 10:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:36 INFO - 'NO_EM_RESTART': '1', 10:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:36 INFO - 'PWD': '/builds/slave/test', 10:45:36 INFO - 'SHELL': '/bin/bash', 10:45:36 INFO - 'SHLVL': '1', 10:45:36 INFO - 'TERM': 'linux', 10:45:36 INFO - 'TMOUT': '86400', 10:45:36 INFO - 'USER': 'cltbld', 10:45:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:36 INFO - '_': '/tools/buildbot/bin/python'} 10:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:45:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:45:38 INFO - Installing collected packages: mozsystemmonitor 10:45:38 INFO - Running setup.py install for mozsystemmonitor 10:45:38 INFO - Successfully installed mozsystemmonitor 10:45:38 INFO - Cleaning up... 10:45:38 INFO - Return code: 0 10:45:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:45:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:45:38 INFO - Using env: {'DISPLAY': ':0', 10:45:38 INFO - 'HOME': '/home/cltbld', 10:45:38 INFO - 'LANG': 'en_US.UTF-8', 10:45:38 INFO - 'LANGUAGE': 'en_US:en', 10:45:38 INFO - 'LOGNAME': 'cltbld', 10:45:38 INFO - 'MAIL': '/var/mail/cltbld', 10:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:38 INFO - 'MOZ_NO_REMOTE': '1', 10:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:38 INFO - 'NO_EM_RESTART': '1', 10:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:38 INFO - 'PWD': '/builds/slave/test', 10:45:38 INFO - 'SHELL': '/bin/bash', 10:45:38 INFO - 'SHLVL': '1', 10:45:38 INFO - 'TERM': 'linux', 10:45:38 INFO - 'TMOUT': '86400', 10:45:38 INFO - 'USER': 'cltbld', 10:45:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:38 INFO - '_': '/tools/buildbot/bin/python'} 10:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:38 INFO - Downloading/unpacking jsonschema==2.5.1 10:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:45:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:40 INFO - Downloading functools32-3.2.3-2.tar.gz 10:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:45:41 INFO - warning: no files found matching '*.txt' 10:45:41 INFO - no previously-included directories found matching 'build' 10:45:41 INFO - no previously-included directories found matching 'dist' 10:45:41 INFO - no previously-included directories found matching '.git*' 10:45:41 INFO - Installing collected packages: jsonschema, functools32 10:45:41 INFO - Running setup.py install for functools32 10:45:41 INFO - warning: no files found matching '*.txt' 10:45:41 INFO - no previously-included directories found matching 'build' 10:45:41 INFO - no previously-included directories found matching 'dist' 10:45:41 INFO - no previously-included directories found matching '.git*' 10:45:41 INFO - Successfully installed jsonschema functools32 10:45:41 INFO - Cleaning up... 10:45:41 INFO - Return code: 0 10:45:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:41 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:41 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:45:41 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 functools32==3.2.3-2 10:45:41 INFO - Using env: {'DISPLAY': ':0', 10:45:41 INFO - 'HOME': '/home/cltbld', 10:45:41 INFO - 'LANG': 'en_US.UTF-8', 10:45:41 INFO - 'LANGUAGE': 'en_US:en', 10:45:41 INFO - 'LOGNAME': 'cltbld', 10:45:41 INFO - 'MAIL': '/var/mail/cltbld', 10:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:41 INFO - 'MOZ_NO_REMOTE': '1', 10:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:41 INFO - 'NO_EM_RESTART': '1', 10:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:41 INFO - 'PWD': '/builds/slave/test', 10:45:41 INFO - 'SHELL': '/bin/bash', 10:45:41 INFO - 'SHLVL': '1', 10:45:41 INFO - 'TERM': 'linux', 10:45:41 INFO - 'TMOUT': '86400', 10:45:41 INFO - 'USER': 'cltbld', 10:45:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:41 INFO - '_': '/tools/buildbot/bin/python'} 10:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:45:41 INFO - Cleaning up... 10:45:41 INFO - Return code: 0 10:45:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:41 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 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:41 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 10:45:41 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 10:45:41 INFO - Using env: {'DISPLAY': ':0', 10:45:41 INFO - 'HOME': '/home/cltbld', 10:45:41 INFO - 'LANG': 'en_US.UTF-8', 10:45:41 INFO - 'LANGUAGE': 'en_US:en', 10:45:41 INFO - 'LOGNAME': 'cltbld', 10:45:41 INFO - 'MAIL': '/var/mail/cltbld', 10:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:41 INFO - 'MOZ_NO_REMOTE': '1', 10:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:41 INFO - 'NO_EM_RESTART': '1', 10:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:41 INFO - 'PWD': '/builds/slave/test', 10:45:41 INFO - 'SHELL': '/bin/bash', 10:45:41 INFO - 'SHLVL': '1', 10:45:41 INFO - 'TERM': 'linux', 10:45:41 INFO - 'TMOUT': '86400', 10:45:41 INFO - 'USER': 'cltbld', 10:45:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:41 INFO - '_': '/tools/buildbot/bin/python'} 10:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:45:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:45:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:45:44 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 10:45:44 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 10:45:44 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 10:45:44 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 10:45:44 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 10:45:44 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 10:45:44 INFO - Downloading docopt-0.6.1.tar.gz 10:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:45:44 INFO - Installing collected packages: blobuploader, requests, docopt 10:45:44 INFO - Running setup.py install for blobuploader 10:45:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:45:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:45:44 INFO - Running setup.py install for requests 10:45:44 INFO - Running setup.py install for docopt 10:45:44 INFO - Successfully installed blobuploader requests docopt 10:45:44 INFO - Cleaning up... 10:45:44 INFO - Return code: 0 10:45:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:44 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 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:44 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 10:45:45 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 10:45:45 INFO - Using env: {'DISPLAY': ':0', 10:45:45 INFO - 'HOME': '/home/cltbld', 10:45:45 INFO - 'LANG': 'en_US.UTF-8', 10:45:45 INFO - 'LANGUAGE': 'en_US:en', 10:45:45 INFO - 'LOGNAME': 'cltbld', 10:45:45 INFO - 'MAIL': '/var/mail/cltbld', 10:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:45 INFO - 'MOZ_NO_REMOTE': '1', 10:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:45 INFO - 'NO_EM_RESTART': '1', 10:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:45 INFO - 'PWD': '/builds/slave/test', 10:45:45 INFO - 'SHELL': '/bin/bash', 10:45:45 INFO - 'SHLVL': '1', 10:45:45 INFO - 'TERM': 'linux', 10:45:45 INFO - 'TMOUT': '86400', 10:45:45 INFO - 'USER': 'cltbld', 10:45:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:45 INFO - '_': '/tools/buildbot/bin/python'} 10:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:45 INFO - Running setup.py (path:/tmp/pip-nv263N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:45 INFO - Running setup.py (path:/tmp/pip-a4YHi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:45 INFO - Running setup.py (path:/tmp/pip-t2WKX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:45 INFO - Running setup.py (path:/tmp/pip-OOV5b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:45 INFO - Running setup.py (path:/tmp/pip-1etChP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:45 INFO - Running setup.py (path:/tmp/pip-O21luc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:45 INFO - Running setup.py (path:/tmp/pip-AMrjsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:45 INFO - Running setup.py (path:/tmp/pip-OIHbeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:45 INFO - Running setup.py (path:/tmp/pip-jOXBSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:45 INFO - Running setup.py (path:/tmp/pip-fkLQSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:45 INFO - Running setup.py (path:/tmp/pip-QIjBJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:46 INFO - Running setup.py (path:/tmp/pip-MD70YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:46 INFO - Running setup.py (path:/tmp/pip-07B_8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:46 INFO - Running setup.py (path:/tmp/pip-TYoPb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:46 INFO - Running setup.py (path:/tmp/pip-NbaqGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:46 INFO - Running setup.py (path:/tmp/pip-YFCIL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:46 INFO - Running setup.py (path:/tmp/pip-6vjH79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:45:46 INFO - Running setup.py install for manifestparser 10:45:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:45:46 INFO - Running setup.py install for mozcrash 10:45:46 INFO - Running setup.py install for mozdebug 10:45:46 INFO - Running setup.py install for mozdevice 10:45:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:45:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:45:46 INFO - Running setup.py install for mozfile 10:45:46 INFO - Running setup.py install for mozhttpd 10:45:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozinfo 10:45:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozInstall 10:45:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozleak 10:45:47 INFO - Running setup.py install for mozlog 10:45:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for moznetwork 10:45:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozprocess 10:45:47 INFO - Running setup.py install for mozprofile 10:45:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozrunner 10:45:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:45:47 INFO - Running setup.py install for mozscreenshot 10:45:48 INFO - Running setup.py install for moztest 10:45:48 INFO - Running setup.py install for mozversion 10:45:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:45:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:45:48 INFO - Cleaning up... 10:45:48 INFO - Return code: 0 10:45:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:48 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 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:48 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 10:45:48 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 10:45:48 INFO - Using env: {'DISPLAY': ':0', 10:45:48 INFO - 'HOME': '/home/cltbld', 10:45:48 INFO - 'LANG': 'en_US.UTF-8', 10:45:48 INFO - 'LANGUAGE': 'en_US:en', 10:45:48 INFO - 'LOGNAME': 'cltbld', 10:45:48 INFO - 'MAIL': '/var/mail/cltbld', 10:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:48 INFO - 'MOZ_NO_REMOTE': '1', 10:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:48 INFO - 'NO_EM_RESTART': '1', 10:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:48 INFO - 'PWD': '/builds/slave/test', 10:45:48 INFO - 'SHELL': '/bin/bash', 10:45:48 INFO - 'SHLVL': '1', 10:45:48 INFO - 'TERM': 'linux', 10:45:48 INFO - 'TMOUT': '86400', 10:45:48 INFO - 'USER': 'cltbld', 10:45:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:48 INFO - '_': '/tools/buildbot/bin/python'} 10:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:45:48 INFO - Running setup.py (path:/tmp/pip-ThOHUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:45:48 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)) 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:45:48 INFO - Running setup.py (path:/tmp/pip-UUwZkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:45:48 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)) 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:45:48 INFO - Running setup.py (path:/tmp/pip-ES611d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:45:48 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)) 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:45:48 INFO - Running setup.py (path:/tmp/pip-QntcVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:45:48 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)) 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:45:48 INFO - Running setup.py (path:/tmp/pip-156b4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:45:48 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)) 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:45:48 INFO - Running setup.py (path:/tmp/pip-8ziZD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:45:48 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)) 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:45:48 INFO - Running setup.py (path:/tmp/pip-zFPt6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:45:48 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)) 10:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:45:48 INFO - Running setup.py (path:/tmp/pip-q8jto3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:45:49 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)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:45:49 INFO - Running setup.py (path:/tmp/pip-gH41jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:45:49 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)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:45:49 INFO - Running setup.py (path:/tmp/pip-x4uBaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:45:49 INFO - Running setup.py (path:/tmp/pip-chCANd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:45:49 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)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:45:49 INFO - Running setup.py (path:/tmp/pip-hv2RVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:45:49 INFO - Running setup.py (path:/tmp/pip-y3AEem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:45:49 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)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:45:49 INFO - Running setup.py (path:/tmp/pip-RrZwhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:49 INFO - Running setup.py (path:/tmp/pip-7GmkHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:45:49 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)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:45:49 INFO - Running setup.py (path:/tmp/pip-It1P5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:45:49 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)) 10:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:45:49 INFO - Running setup.py (path:/tmp/pip-56hBvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 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)) 10:45:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:45:49 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 10:45:49 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 10:45:49 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 10:45:49 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 10:45:49 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 10:45:49 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 10:45:51 INFO - Downloading blessings-1.6.tar.gz 10:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:45:51 INFO - Installing collected packages: blessings 10:45:51 INFO - Running setup.py install for blessings 10:45:51 INFO - Successfully installed blessings 10:45:51 INFO - Cleaning up... 10:45:51 INFO - Return code: 0 10:45:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:45:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:52 INFO - Reading from file tmpfile_stdout 10:45:52 INFO - Current package versions: 10:45:52 INFO - argparse == 1.2.1 10:45:52 INFO - blessings == 1.6 10:45:52 INFO - blobuploader == 1.2.4 10:45:52 INFO - docopt == 0.6.1 10:45:52 INFO - functools32 == 3.2.3-2 10:45:52 INFO - jsonschema == 2.5.1 10:45:52 INFO - manifestparser == 1.1 10:45:52 INFO - mozInstall == 1.12 10:45:52 INFO - mozcrash == 0.17 10:45:52 INFO - mozdebug == 0.1 10:45:52 INFO - mozdevice == 0.48 10:45:52 INFO - mozfile == 1.2 10:45:52 INFO - mozhttpd == 0.7 10:45:52 INFO - mozinfo == 0.9 10:45:52 INFO - mozleak == 0.1 10:45:52 INFO - mozlog == 3.4 10:45:52 INFO - moznetwork == 0.27 10:45:52 INFO - mozprocess == 0.23 10:45:52 INFO - mozprofile == 0.28 10:45:52 INFO - mozrunner == 6.12 10:45:52 INFO - mozscreenshot == 0.1 10:45:52 INFO - mozsystemmonitor == 0.3 10:45:52 INFO - moztest == 0.7 10:45:52 INFO - mozversion == 1.4 10:45:52 INFO - psutil == 3.1.1 10:45:52 INFO - requests == 1.2.3 10:45:52 INFO - wsgiref == 0.1.2 10:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:52 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 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:52 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 10:45:52 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 10:45:52 INFO - Using env: {'DISPLAY': ':0', 10:45:52 INFO - 'HOME': '/home/cltbld', 10:45:52 INFO - 'LANG': 'en_US.UTF-8', 10:45:52 INFO - 'LANGUAGE': 'en_US:en', 10:45:52 INFO - 'LOGNAME': 'cltbld', 10:45:52 INFO - 'MAIL': '/var/mail/cltbld', 10:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:52 INFO - 'MOZ_NO_REMOTE': '1', 10:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:52 INFO - 'NO_EM_RESTART': '1', 10:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:52 INFO - 'PWD': '/builds/slave/test', 10:45:52 INFO - 'SHELL': '/bin/bash', 10:45:52 INFO - 'SHLVL': '1', 10:45:52 INFO - 'TERM': 'linux', 10:45:52 INFO - 'TMOUT': '86400', 10:45:52 INFO - 'USER': 'cltbld', 10:45:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:52 INFO - '_': '/tools/buildbot/bin/python'} 10:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 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)) 10:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:45:52 INFO - Cleaning up... 10:45:52 INFO - Return code: 0 10:45:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f49ef4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2102ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, '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': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', '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 10:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:45:52 INFO - Using env: {'DISPLAY': ':0', 10:45:52 INFO - 'HOME': '/home/cltbld', 10:45:52 INFO - 'LANG': 'en_US.UTF-8', 10:45:52 INFO - 'LANGUAGE': 'en_US:en', 10:45:52 INFO - 'LOGNAME': 'cltbld', 10:45:52 INFO - 'MAIL': '/var/mail/cltbld', 10:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:45:52 INFO - 'MOZ_NO_REMOTE': '1', 10:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:45:52 INFO - 'NO_EM_RESTART': '1', 10:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:45:52 INFO - 'PWD': '/builds/slave/test', 10:45:52 INFO - 'SHELL': '/bin/bash', 10:45:52 INFO - 'SHLVL': '1', 10:45:52 INFO - 'TERM': 'linux', 10:45:52 INFO - 'TMOUT': '86400', 10:45:52 INFO - 'USER': 'cltbld', 10:45:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:45:52 INFO - '_': '/tools/buildbot/bin/python'} 10:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:45:52 INFO - Cleaning up... 10:45:52 INFO - Return code: 0 10:45:52 INFO - Running post-action listener: _resource_record_post_action 10:45:52 INFO - Running post-action listener: _start_resource_monitoring 10:45:52 INFO - Starting resource monitoring. 10:45:52 INFO - [mozharness: 2016-10-13 17:45:52.584192Z] Finished create-virtualenv step (success) 10:45:52 INFO - [mozharness: 2016-10-13 17:45:52.584697Z] Running install step. 10:45:52 INFO - Running pre-action listener: _resource_record_pre_action 10:45:52 INFO - Running main action method: install 10:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:45:52 INFO - Reading from file tmpfile_stdout 10:45:52 INFO - Detecting whether we're running mozinstall >=1.0... 10:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:45:52 INFO - Reading from file tmpfile_stdout 10:45:52 INFO - Output received: 10:45:52 INFO - Usage: mozinstall [options] installer 10:45:52 INFO - Options: 10:45:52 INFO - -h, --help show this help message and exit 10:45:52 INFO - -d DEST, --destination=DEST 10:45:52 INFO - Directory to install application into. [default: 10:45:52 INFO - "/builds/slave/test"] 10:45:52 INFO - --app=APP Application being installed. [default: firefox] 10:45:52 INFO - mkdir: /builds/slave/test/build/application 10:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:46:09 INFO - Reading from file tmpfile_stdout 10:46:09 INFO - Output received: 10:46:09 INFO - /builds/slave/test/build/application/firefox/firefox 10:46:09 INFO - Running post-action listener: _resource_record_post_action 10:46:09 INFO - [mozharness: 2016-10-13 17:46:09.052953Z] Finished install step (success) 10:46:09 INFO - [mozharness: 2016-10-13 17:46:09.053198Z] Running run-tests step. 10:46:09 INFO - Running pre-action listener: _resource_record_pre_action 10:46:09 INFO - Running main action method: run_tests 10:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:46:09 INFO - Python 2.7.3 10:46:09 INFO - Return code: 0 10:46:09 INFO - grabbing minidump binary from tooltool 10:46: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20fff60>, '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 0x2100d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21011d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:46:09 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 10:46:09 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 10:46:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:46:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:46:09 INFO - Return code: 0 10:46:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:46:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:46:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:46:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:46:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:46:09 INFO - Using env: {'DISPLAY': ':0', 10:46:09 INFO - 'HOME': '/home/cltbld', 10:46:09 INFO - 'LANG': 'en_US.UTF-8', 10:46:09 INFO - 'LANGUAGE': 'en_US:en', 10:46:09 INFO - 'LOGNAME': 'cltbld', 10:46:09 INFO - 'MAIL': '/var/mail/cltbld', 10:46:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:46:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:46:09 INFO - 'MOZ_NO_REMOTE': '1', 10:46:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:46:09 INFO - 'NO_EM_RESTART': '1', 10:46:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:46:09 INFO - 'PWD': '/builds/slave/test', 10:46:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:46:09 INFO - 'SHELL': '/bin/bash', 10:46:09 INFO - 'SHLVL': '1', 10:46:09 INFO - 'TERM': 'linux', 10:46:09 INFO - 'TMOUT': '86400', 10:46:09 INFO - 'USER': 'cltbld', 10:46:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240', 10:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:46:09 INFO - '_': '/tools/buildbot/bin/python'} 10:46:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:46:09 INFO - mozversion application_buildid: 20161013094723 10:46:09 INFO - mozversion application_changeset: 7452437b3ab571b1d60aed4e973d82a1471f72b2 10:46:09 INFO - mozversion application_display_name: Nightly 10:46:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:46:09 INFO - mozversion application_name: Firefox 10:46:09 INFO - mozversion application_remotingname: firefox 10:46:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:46:09 INFO - mozversion application_vendor: Mozilla 10:46:09 INFO - mozversion application_version: 52.0a1 10:46:09 INFO - mozversion platform_buildid: 20161013094723 10:46:09 INFO - mozversion platform_changeset: 7452437b3ab571b1d60aed4e973d82a1471f72b2 10:46:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:46:09 INFO - mozversion platform_version: 52.0a1 10:46:09 INFO - using testdate: 1476380769 10:46:09 INFO - actual date: 1476380769 10:46:09 INFO - starting webserver on 'localhost:35384' 10:46:09 INFO - SUITE-START | Running 2 tests 10:46:09 INFO - TEST-START | dromaeo_css 10:46:09 INFO - operating with platform_type : linux_ 10:46:09 INFO - Initialising browser for dromaeo_css test... 10:46:09 INFO - TEST-INFO | started process 20934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpucnhfu/profile http://localhost:35384/getInfo.html) 10:46:13 INFO - PROCESS | 20934 | __metrics Screen width/height:1600/1200 10:46:13 INFO - PROCESS | 20934 | colorDepth:24 10:46:13 INFO - PROCESS | 20934 | Browser inner width/height: 1024/697 10:46:13 INFO - PROCESS | 20934 | __metrics 10:46:14 INFO - PROCESS | 20934 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:46:14 INFO - PROCESS | 20934 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:46:14 INFO - PROCESS | 20934 | console.error: PushService: 10:46:14 INFO - PROCESS | 20934 | stateChangeProcessEnqueue: Error transitioning state 10:46:14 INFO - PROCESS | 20934 | UnknownError 10:46:15 INFO - TEST-INFO | 20934: exit 0 10:46:15 INFO - Browser initialized. 10:46:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:46:15 INFO - TEST-INFO | started process 21018 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpucnhfu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:27 INFO - PROCESS | 21018 | RSS: Main: 174632960 10:46:27 INFO - PROCESS | 21018 | 10:47:19 INFO - PROCESS | 21018 | 1476380839577 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] 10:49:33 INFO - PROCESS | 21018 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35384/tests/dromaeo/cssquery-ext.html) 10:49:34 INFO - PROCESS | 21018 | RSS: Main: 322613248 10:49:34 INFO - PROCESS | 21018 | 10:52:37 INFO - PROCESS | 21018 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-ext.html (next: http://localhost:35384/tests/dromaeo/cssquery-jquery.html) 10:52:38 INFO - PROCESS | 21018 | RSS: Main: 276021248 10:52:38 INFO - PROCESS | 21018 | 10:55:40 INFO - PROCESS | 21018 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35384/tests/dromaeo/cssquery-mootools.html) 10:55:40 INFO - PROCESS | 21018 | RSS: Main: 228933632 10:55:40 INFO - PROCESS | 21018 | 10:58:43 INFO - PROCESS | 21018 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35384/tests/dromaeo/cssquery-prototype.html) 10:58:43 INFO - PROCESS | 21018 | RSS: Main: 268439552 10:58:43 INFO - PROCESS | 21018 | 11:01:46 INFO - PROCESS | 21018 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35384/tests/dromaeo/cssquery-yui.html) 11:01:47 INFO - PROCESS | 21018 | RSS: Main: 221741056 11:01:47 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | Cycle 1(1): loaded http://localhost:35384/tests/dromaeo/cssquery-yui.html (next: http://localhost:35384/tests/dromaeo/cssquery-dojo.html) 11:04:50 INFO - PROCESS | 21018 | RSS: Main: 304726016 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | __start_tp_report 11:04:50 INFO - PROCESS | 21018 | _x_x_mozilla_page_load 11:04:50 INFO - PROCESS | 21018 | _x_x_mozilla_page_load_details 11:04:50 INFO - PROCESS | 21018 | |i|pagename|runs| 11:04:50 INFO - PROCESS | 21018 | |0;dojo.html;2583.2895953612756;2614.4509652972874;2648.8278261912974;2654.442567060917;2665.093868084852;4595.4715207751115;4691.812327506896;4696.857213560999;4792.8801779955475;4794.161021821181;4690.5074967128385;4707.858764237069;4710.882227944303;4727.9290810637785;4728.858134255978;4325.956740432594;4360.23695853226;4373.759443230621;4400.955990440087;4428.889277768049;4363.258246098171;4391.780410979438;4398.64810815134;4401.185780630578;4401.647868170555;4382.693211475198;4392.604665580097;4395.1868904252815;4420.425344705184;4447.2439685253585;4466.196084704752;4487.214737420938;4501.347304640809;4533.5013148553635;4552.795124219418;4235.322348424237;4261.616454519108;4348.304271316574;4391.9780401098105;4413.44831896013;4792.0895029944195;4805.903881922377;4825.20384136617;4829.2997515360075;4909.852704418873;5147.819826306061;5153.739337433027;5165.870853228662;5172.094883395391;5193.506616871391;4952.4057113146655;4995.425526064513;5001.249812528114;5172.405173405069;5190.143626301656;4678.836240731558;4732.787024583902;4744.146053710365;4762.499937506581;4823.083614113307;5205.323307970016;5208.609354298443;5214.113600687816;5219.451957544479;5281.102212623863;4982.750862456863;4991.3511243538105;4992.051510213048;4994.2508623706735;5061.5950723942;4939.086269040239;4998.425181104147;4999.225120106389;5100.1074811907765;5147.768350424165;5121.28302037715;5124.180131179068;5169.9741501293;5181.792728290826;5183.248428977777;5081.212412076134;5090.363704536933;5099.796008159632;5101.897962040738;5111.3355263815465;4057.472528571267;4093.017675757856;4097.262492751333;4268.765217913045;4277.165952639268;3675.0628589709454;3692.9261414771554;3694;3695.8336874840697;3748.475213470116;4393.890152746207;4395.956040439619;4398.406215160912;4413.7351758894565;4459.264221403432;4856.150173719585;5037.0681423936685;5038.84883453497;5046.9747651261505;5057.898842023139;4289.528151903288;4339.349097635317;4433.933490997638;4459.487158976694;4465.553444655508;4602.470715867651;4606.585407313358;4611.262198048364;4644.256918893028;4668.766561671903;4894.755262236874;4900.117978763857;4902.730349830794;4908.067467181224;4965.230389289666;4949.059678661043;5009.599232061353;5014;5043.470435604208;5176;4820.566149046603;4832.516748325139;4836.322914792002;4902.436219834622;4916.237983112624;5014.122528557561;5017.64876458659;5018.272350509229;5018.673786203885;5066.771995260148;4919.1883339248625;4988.501149884983;5037.722925239001;5079.263506791568;5165.715885626327;4934.50654934518;4982.402111746614;4993;4995.275685025724;5052.646314757932;4948.826791062295;4973.129702302155;4979.427365852828;4981.825636102719;5040.924386134137;4772.5227477252;4920.434150072788;4947.307376967299;4953.281774142802;5011.248312753116;4906.2640603909695;4982.053409852117;5005.274235235943;5014.674046187132;5073.847784566469;4912.38595175603;4912.484189160086;4925.433575138905;4925.704457732548;4992.101421744121 11:04:50 INFO - PROCESS | 21018 | |1;ext.html;560.3164139749507;560.7420586530195;572.4075581772865;574.7729646789518;579.5392662833048;27831.44337113259;28568.714312856864;37933.43099853501;39079.41380879282;39382.60617393825;38975.220495590074;39271.80364098176;39332.60667393325;39357.212855742866;39396.40905386421;7521.51110177838;7668.118166410851;7672.386209103286;7674.654640541189;7678;7553.924460755377;7637.732679356223;7638.503497272687;7640.770776876702;7642.808929776745;7658.3873290136935;7681.50070245435;7689.961550192269;7695.4997925134685;7698.884516732253;7602.42981776369;7642.541447513167;7647.197044310323;7651.043619547557;7653.15815260321;7600.049993750781;7658.234176582353;7666.118396384431;7666.9616651916385;7668.693252269903;36323.63676363229;36589.634103658886;36590.63409365899;36709.632903671154;36720.26559468795;3038.4226996870525;3146.103360542257;3211.614606247242;3362.1090411041096;3362.142653623335;27189.728102718916;27499.587506187425;27773.305667358276;27895;27994;3435.707964822968;3483.599386070609;3577.159367548624;3632.1827588792576;3636.236390358028;230415;230587;231346;231898;232079;29953.850230748707;49233.50766492361;49354.75322623436;49628;49743;31185.688143118732;32817.3436531268;33100.83449582785;33123.171920702174;33459.66540334614;12739.299338536284;12795.872041279468;12806.103572749818;12817.1668841525;12835.614931552069;9700.466474343979;9749.31754777173;9751.90248097524;9762.658306959222;9768.413895166314;7700.807479812937;7761.107472640606;7811.101723301779;7836.764897053097;7843.72546960865;3018.894338698135;3083.814971101741;3113.688631136868;3141.89003384885;3178.0783572764103;838.9748307550783;869.3610196505564;891.5230351761776;920.7329874336367;971.868797712314;27030.32424189411;27562.5865612016;27651.58522622162;27695.584566231522;28004.159875203775;921.4701546610726;938.5682586010512;950.5722424908819;954.5084281594984;1017.0084167936351;13995.440182392591;14771.33528991198;14904.925475372555;15133.319000644777;15185.848141518665;357218;363586;364688;365105;365550;32312.515312270334;32606.347873042407;32613.34773304568;32683.673163268537;32725;1040.6825918095053;1054.056619325699;1091.9890801091888;1178.8408564843808;1193.773183095209;25590.360240994123;28570.857145714137;28905.710942891143;28956.42087158287;29535.704642953297;40595;41063.589364105974;41140.58859411367;41143.17713645651;41151.88481151861;275257;276177;276345;276345;276513;21407.46481337979;22452.663210051534;23520.647190291817;24890;24975.625365619893;39400.802995984835;39462.34535495283;40028.799856000536;40063.599364007154;40472.1905561893;34229.828850855585;34462.310753785285;34729;35254.82372588121;35542.64457355497;34126.31747365089;34528.309433811686;34703;34852.825735871156;35190.29619407546;34265.143371415914;34713;34819.12952176216;34856.65143348534;35190.29619407546;29351;31821;31867.840660797476;31950.68049319477;31955;24612.876935615208;24840;25313.49373012566;30485.847570762893;30834.383312334077 11:04:50 INFO - PROCESS | 21018 | |2;jquery.html;366.75060958548187;368.37744212281234;369.5491500369548;388.1848118950203;393.66538442324025;15173.620659483504;15510.379584816594;16643.417480388172;16811.663766724658;16844.24200910959;15961.521154365359;16167.676646467064;16311.510654680349;16723.247453864577;16812.747808782846;4916.311716359713;5192.740362981855;5208.348956380452;5209.322788037569;5212.765425555859;4959.826406075788;5110.514501122388;5123.641345105844;5148.613853960949;5175.327207463025;5111.948880511203;5112.0287145442435;5128.179491281396;5148.794048238066;5155.200943853709;4918.2376731606655;5109.540141387256;5110.156824124015;5114.693118412907;5118.053160165363;4558.270676691714;4592.931106033412;4594.425696787902;4601.033782905593;4602.654800889946;16988.150592470327;17114.657706845792;19086.713699294523;20214.49463763403;20288.898555507276;1898.6012937283188;1958.4907923939736;2079.386580958606;2187.8359123065834;2237.3735354100877;9439.764005899839;9504.714858554255;11963.342016189106;12107.39463026854;12708.936455317664;1745.5461579989167;1762.0484938133393;1765.0821572782081;1785.7410675451986;1809.9547511312192;66246;68440.6577967107;68642.65678671625;69113.65443172753;69963.65018174927;9001.189892909539;9057.456552606733;9238.67664631748;9347.345685801929;9393.107654772923;12172.878271217352;12173.513059477522;12197.817032744517;12220.877791221974;12283.140180187302;6614.801555953329;6824.385805277549;6831.180258368928;6886.586804791628;7286.380657644159;6449.258335291408;6593.901091483632;6643.86712265752;6672.83317917056;6678.131842860397;3810.657040866335;3814.961850381461;4167.874963751093;4309.525952145262;4381.846635367747;1729.714597091491;1754.9034803085697;1790.9462716118537;1796.1917137288272;1807.150639199574;812.6099472253352;815.2499700275761;842.7303262955795;845.2055068235838;894.7002754077326;16261.268242929096;16569.585760355847;17280.827191728175;17333.7399939001;17380.3047878086;823.8640624296924;843.4433274039105;847.7160151349244;851.9446235994765;868.8653258744778;9244.583993720164;9275.304352173614;9685.757856053515;9717.271204659679;9868.80262394748;361185;364334;364432;365210;372150;47895;49560.75219623879;77535.22464775393;77994.61002695064;78102;806.733777853307;851.1658574596929;851.5274022917216;852.2244757270854;853.6329378367361;15269.6182595436;15478.368677325107;15615.843841561893;15616.375344986074;16307.59231019234;33829;34862.82568587242;36092.819535902156;38629;39935.80032099821;48418.757906210245;51783.48216517787;52106.21840672317;53734;53966.46033539614;6634.137562116894;6925.6190909500465;6927.549709268881;6985.685644146127;7213.855722885618;8946.597403116744;11332.716682083013;12019.4591243396;12290.569830055905;12480.937595311965;10378.844317335397;10404.323718958243;10422.843657345298;10722.356658600509;10814.89185108139;10176.89823101789;10386.532606032595;10697.358158510515;10708.143348531943;10746.140308775435;9982;10417;10572.36565806054;10684.46577671129;10870.880178365143;7027.191872934678;7152.785416437307;7192.784216473514;7258.165310989304;7294.817629559091;9811.754706132404;10429;10496.107830834464;10502.68491945243;10834.458277085956 11:04:50 INFO - PROCESS | 21018 | |3;mootools.html;1079.3200283821193;1092.8360745888122;1220.2190598017264;1263.2799304396497;1277.1443133100825;6551.508636852237;7753.185915478871;8007.959960200191;8009;8010.198980101987;8039.196080391958;8106.878396824052;8107.18928107189;8109.891428228659;8113.8782918256275;2218.4786575154867;2251.808596269319;2252.200468833557;2252.279270633398;2255.221948427798;2169.5010147665967;2208.3595757230464;2226;2228.721409823772;2229.1306390507634;2186.365953873375;2202.0641227478336;2208.4258092895884;2212.9557408851815;2228.4206106412366;2147.1840700533853;2154.407537927075;2166.5341951480427;2168.056895250571;2170.6526955687173;2142.1752625239237;2142.3465842917904;2143.046344376753;2143.6355819510723;2147.7852214778554;7878.566678832662;8011.158828323;8042.075161356402;8118.228768267005;8125.59372031402;4708.882277943045;4935.2843837643695;4940.036692844897;4941.332920055818;4947.529984651488;2978.2405486600996;3098.9535156972665;3151.1176870476074;3155.9053228403186;3176.6029246344206;926.8748718922926;929.4748467116058;936.7049379445521;937.3485427627801;961.9855702164473;10970.341779493256;11109.777804443866;11111.499982500807;11138.832917506163;11145.832812507737;4156.45966024421;4205.726627769185;4285.5928686774705;4296.785160741951;4315.3742707307265;8698.086700896441;8700.34747393948;8710.21608055278;8710.390272680852;8711.259542938795;4766.95233047672;4777.116233496814;4780.115678599401;4785.808567657255;4786.7845946932475;3559.341521818472;3670.724695647837;4158.209940111369;4293.656507479394;4449.065696203768;3346.1467325832245;3350.346682396958;3427;3447.7241820654285;3461.584609846784;1048.7535429174138;1065.0787069185253;1065.2064212161833;1075.2849355178876;1075.7095584192225;697.8429853283072;819.7581713394563;827.4001349021911;830.1283652165203;838.3963546246692;5186.118359878829;5225.581953443715;5257.08001099806;5310.468953104736;5317.175837745156;412.93805929110874;418.6922611880266;426.1583372838681;431.26469369724543;434.83476279013775;3619.2580520993133;3697.2605478904325;3776.905577360588;3846.576876543578;3917.6082391761165;9558.761030974281;9835.114839664464;9942.850857237147;9947.303688741864;9954.208242516272;9863.408195508293;9868.111869931741;9888.159506442033;9893.258005649604;9896.55465504054;6760.019797129487;7025.121859767529;7040.788776336718;7209.89185162223;7214.819629509199;5287.365516138088;5399.757010934439;5407.972960135332;5417.268668729671;5556.805511807067;8841.275951189456;8902.465852048897;9113.088691131099;9142.680006199751;9206.815863682823;8893.822123557622;8894.42186257891;9279.072092790937;9291.907080929375;9306.534673266446;6009.188759517409;6202.255729312511;6212.223472065992;6962.512624116263;7159.928400715926;6969.4424446045205;7023.33278338557;7291.708331666674;7594;7612.3910087194;6936.514443988873;7149.320814522612;7269.854602908018;7276.126864776261;7405.62971851416;7063.646817658993;7088.397486213524;7110.217876033736;7127.607981561064;7217.278272172741;6112.847178820565;6250.843728906631;6308.211473565804;6415.326390729093;6479;4718.292256161603;4745.2882067690125;4785.784639691292;4828.686135401188;4898.2652602109965;4873.829415970424;4942.925856112233;4973.776180071833;5013.523715247045;5054.21659642756 11:04:50 INFO - PROCESS | 21018 | |4;prototype.html;295.7382716296076;300.0907251029381;305.592034633764;309.1883805011844;312.6014331727049;4578.267477203648;4702.4827269000425;4723.740194289313;4756.643251756119;4775.188218002939;4522.670824525372;4646.3030545418205;4656.9534304656945;4666.136764698533;4689.413823272091;3760.548734151892;3767.585565587783;3768.981155094221;3769.453429252757;3772.1135533149686;3558.2349794794113;3749.343864823645;3766.0773110587943;3774.67915227206;3799.297130030939;3479.9130021749406;3725.2363265530635;3754.2116155607355;3765.3975363941777;3776.716746244029;3733.3653278942643;3735.6451137141926;3739.738218324718;3765.7175711821724;3768.8492460301554;3306.9173270668184;3312.138843900579;3314.303996160809;3331.4669652855428;3340.1816554944194;4531.388262584542;4560.726356418625;4582.33556134362;4639.976800116012;4660.580547750718;4221.387898754694;4229.238737027334;4248.704145235702;4255.319148936155;4267.829286828523;4925.827596034122;4932.457429682732;4935.925961110586;4942.752862356903;4959.156943319645;3462.826858657057;3611.638836116367;3630.3102410541915;3635.291118231946;3635.8545658173643;5058.2412638104215;5065.265536497187;5140.742962851842;5170.302009228743;5175.146100893348;3653.4519822026377;3655.634436556323;3658.70730341572;3661.835217415223;3663.2673465307043;3708;3708.796016219134;3729.589745128088;3764.3036038333;3771.17034252464;3962.9009274767786;4187.644050255702;4189.371594260885;4247.8088486018205;4250.362445633118;4884.4871288514905;4897.804087836518;4901.852944411602;4902.754862256944;4905.509449055137;1180.5100883133575;1205.8604618635306;1255.5919326219016;1268.536984000833;1276.6999755057554;834.7203686765001;868.2316150206985;871.1288711288711;876.6186708781573;882.9360620452339;4390;4399.670024748157;4413.801378937956;4416.337549367557;4444.31113177458;4996.875078123004;5021.347224860745;5046.1926091825135;5047.899042019139;5048.671836330626;4249.723767955073;4393.384926110347;4468.240399132155;4470.754108524063;4488.304312831517;2668.7331266873157;2678.8882613715477;2680.7051224365305;2684.1813246959864;2693.5286324893063;4808.8797780055775;4809.855704328876;4844;4848.684835485753;4856.344393506902;5020.47285035066;5142.177251639794;5157.742112894341;5187.610929180251;5197.818076367309;4824.831130910471;4826.95173048272;4833.782479788348;4839.765859705823;4845.63657725665;5040.974795126148;5042.949570504248;5059.443461219189;5076.36545431821;5080.847574572768;4708.387909571734;4897.4857639947295;4918.311436398979;4941.555260026615;4947.505249475023;4812.951870481251;4814.350062741625;4815.807367705253;4829.991107380935;4851.51484851512;3589.820508974593;3613.620569840234;3617.0957260684827;3619.8190090495896;3621.4386770050683;4822.831200907952;5054.924176137434;5065.39215294167;5081.5426611605135;5091.770870310771;4843.007183527439;4869.829555965524;4877.6341774367775;4882;4884.5603895649565;4847.61219102478;4868.101440438303;4878.219484882402;4882.048000639983;4904.062895156465;4571.26859702446;4588.26587745959;4747;4829.299751536078;4863.148948933993;4775.21209000525;4919;4924.325729251928;4932.506749325039;4934.457209706858;4832.477769502595;4833.371661683958;4838.467768545527;4858.46556878736;4878.268259761065 11:04:50 INFO - PROCESS | 21018 | |5;yui.html;616.063583353303;632.3234139470762;665.1552528289071;685.5920727167335;718.7699936020475;12661.177023493467;13377.799333010013;13387.93306033471;13394.263315517643;13443.932780336097;12713.300768457731;12734.808977865316;12756.362181890914;12801.935990320058;12811.359432028408;620.5873094392224;634.6604566556892;753.6683859101992;758.859610971972;779.5478622399023;772.4168252969029;774.9728759493419;775.151209425678;775.3796962430062;775.7246177606953;830.8961379827522;831.1107115386538;831.1397703377006;831.4346244553701;832.8875601793771;650.5901282192212;664.4651055899999;782.8434313137395;804.0271271761176;809.3080416244144;585.0405335250193;595.4849055566947;595.9851003724898;596.0493013643276;596.8507873031742;12174.330411827346;12189.085818563555;12206.938965305117;12261.632151035394;12297.508099676003;12252.264864108181;12440.253584784941;12628.558000469939;12737.172083814523;12992.935035324763;11206.495707693091;11233.775324493547;11479.311241325464;11589;11955.880441195564;3829.751066180689;3831.7892515911612;3842.6733727633186;3886.417037444378;3995.60043995601;61278;61499;61839.6908015457;62463.68768156176;62496.37503624951;9685.612575497042;9820.857325655865;9823.410595364301;10012.04885535873;10122.089011988955;18897.055147242583;18984.240630374905;18985.145668444955;19098.427047188605;19098.52253693641;6481.740730370732;6511.120998665119;6527.706253218616;6581.736730530725;6682.431993280528;3527.876524321636;3556.8043757593064;3591.51514545533;3594.5866225383893;3689.4465830125696;2721.265258380266;2809.9157025289273;2812.7890408219055;2817.4505971335802;2819.746222839954;463.16167736396557;470.9646776491708;475.51972507766715;478.4880178209352;486.3215813939605;439.19188692804755;524.3969435149609;540.0198639469351;560.1206106412893;574.5575906551932;7337.706491740378;7502.17476077631;7650.693972241048;7711.344535714415;7948.761537153895;509.9184130539096;550.4193076304538;561.3348182403864;565.3216140631259;577.9855503612443;3597.0647631615966;3639.454081887738;3643.9635603644156;3664.72514561409;3833.3483307837732;55104;80339.7949030765;92108.53945730228;98521.50739246258;99406.5029674847;45287.54712452833;52761.47238527566;65020.34979650238;66982;82020.58989705013;42345.788271058445;42638.57361426346;50340.748296259015;65421.34578654248;69382.65308673424;7620.399716059689;7893.802654933443;8241.423100382915;8364.456310339809;8530.658773648984;40126.79936600298;41227.7938610317;41677.16645667009;42221.788891055345;43403.34894976641;34168.48747268843;34802;35715.28569428545;38591.80704096462;38728.419073713354;10810.783784324427;11055.502502387573;11067.169962253025;11312.717182070513;11944.70138246516;12036.518539258332;12044.603719642093;12402.25586464815;12525.74948501043;12683.80974285405;11063.626549121595;11767.882321177021;12103.092268080105;12198.57304994321;12351.567695130627;11346.546138154381;12090.516379344728;12148.939255303667;12185.756284874076;12227.327496987395;10517.73705657334;10833.349999000086;11182.273152245078;11204.159688023268;11211.439428028403;9628.277879158952;9727.756806079904;9911.65309214174;10022.799544008933;10177.338472999232;8508.712153242483;9310.627574897198;9730.708078757649;9881.950590247003;10046 11:04:50 INFO - PROCESS | 21018 | __end_tp_report 11:04:50 INFO - PROCESS | 21018 | __start_cc_report 11:04:50 INFO - PROCESS | 21018 | _x_x_mozilla_cycle_collect,1541 11:04:50 INFO - PROCESS | 21018 | __end_cc_report 11:04:50 INFO - PROCESS | 21018 | __startTimestamp1476381890661__endTimestamp 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | ------- Summary: start ------- 11:04:50 INFO - PROCESS | 21018 | Number of tests: 6 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | [#0] dojo.html Cycles:165 Average:4709.58 Median:4902.73 stddev:504.85 (10.3%) stddev-sans-first:478.04 11:04:50 INFO - PROCESS | 21018 | Values: 2583.3 2614.5 2648.8 2654.4 2665.1 4595.5 4691.8 4696.9 4792.9 4794.2 4690.5 4707.9 4710.9 4727.9 4728.9 4326.0 4360.2 4373.8 4401.0 4428.9 4363.3 4391.8 4398.6 4401.2 4401.6 4382.7 4392.6 4395.2 4420.4 4447.2 4466.2 4487.2 4501.3 4533.5 4552.8 4235.3 4261.6 4348.3 4392.0 4413.4 4792.1 4805.9 4825.2 4829.3 4909.9 5147.8 5153.7 5165.9 5172.1 5193.5 4952.4 4995.4 5001.2 5172.4 5190.1 4678.8 4732.8 4744.1 4762.5 4823.1 5205.3 5208.6 5214.1 5219.5 5281.1 4982.8 4991.4 4992.1 4994.3 5061.6 4939.1 4998.4 4999.2 5100.1 5147.8 5121.3 5124.2 5170.0 5181.8 5183.2 5081.2 5090.4 5099.8 5101.9 5111.3 4057.5 4093.0 4097.3 4268.8 4277.2 3675.1 3692.9 3694.0 3695.8 3748.5 4393.9 4396.0 4398.4 4413.7 4459.3 4856.2 5037.1 5038.8 5047.0 5057.9 4289.5 4339.3 4433.9 4459.5 4465.6 4602.5 4606.6 4611.3 4644.3 4668.8 4894.8 4900.1 4902.7 4908.1 4965.2 4949.1 5009.6 5014.0 5043.5 5176.0 4820.6 4832.5 4836.3 4902.4 4916.2 5014.1 5017.6 5018.3 5018.7 5066.8 4919.2 4988.5 5037.7 5079.3 5165.7 4934.5 4982.4 4993.0 4995.3 5052.6 4948.8 4973.1 4979.4 4981.8 5040.9 4772.5 4920.4 4947.3 4953.3 5011.2 4906.3 4982.1 5005.3 5014.7 5073.8 4912.4 4912.5 4925.4 4925.7 4992.1 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | [#1] ext.html Cycles:180 Average:42765.64 Median:34854.74 stddev:77782.59 (223.2%) stddev-sans-first:77936.24 11:04:50 INFO - PROCESS | 21018 | Values: 560.3 560.7 572.4 574.8 579.5 27831.4 28568.7 37933.4 39079.4 39382.6 38975.2 39271.8 39332.6 39357.2 39396.4 7521.5 7668.1 7672.4 7674.7 7678.0 7553.9 7637.7 7638.5 7640.8 7642.8 7658.4 7681.5 7690.0 7695.5 7698.9 7602.4 7642.5 7647.2 7651.0 7653.2 7600.0 7658.2 7666.1 7667.0 7668.7 36323.6 36589.6 36590.6 36709.6 36720.3 3038.4 3146.1 3211.6 3362.1 3362.1 27189.7 27499.6 27773.3 27895.0 27994.0 3435.7 3483.6 3577.2 3632.2 3636.2 230415.0 230587.0 231346.0 231898.0 232079.0 29953.9 49233.5 49354.8 49628.0 49743.0 31185.7 32817.3 33100.8 33123.2 33459.7 12739.3 12795.9 12806.1 12817.2 12835.6 9700.5 9749.3 9751.9 9762.7 9768.4 7700.8 7761.1 7811.1 7836.8 7843.7 3018.9 3083.8 3113.7 3141.9 3178.1 839.0 869.4 891.5 920.7 971.9 27030.3 27562.6 27651.6 27695.6 28004.2 921.5 938.6 950.6 954.5 1017.0 13995.4 14771.3 14904.9 15133.3 15185.8 357218.0 363586.0 364688.0 365105.0 365550.0 32312.5 32606.3 32613.3 32683.7 32725.0 1040.7 1054.1 1092.0 1178.8 1193.8 25590.4 28570.9 28905.7 28956.4 29535.7 40595.0 41063.6 41140.6 41143.2 41151.9 275257.0 276177.0 276345.0 276345.0 276513.0 21407.5 22452.7 23520.6 24890.0 24975.6 39400.8 39462.3 40028.8 40063.6 40472.2 34229.8 34462.3 34729.0 35254.8 35542.6 34126.3 34528.3 34703.0 34852.8 35190.3 34265.1 34713.0 34819.1 34856.7 35190.3 29351.0 31821.0 31867.8 31950.7 31955.0 24612.9 24840.0 25313.5 30485.8 30834.4 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | [#2] jquery.html Cycles:180 Average:23156.28 Median:4575.60 stddev:60352.76 (1319.0%) stddev-sans-first:60497.81 11:04:50 INFO - PROCESS | 21018 | Values: 366.8 368.4 369.5 388.2 393.7 15173.6 15510.4 16643.4 16811.7 16844.2 15961.5 16167.7 16311.5 16723.2 16812.7 4916.3 5192.7 5208.3 5209.3 5212.8 4959.8 5110.5 5123.6 5148.6 5175.3 5111.9 5112.0 5128.2 5148.8 5155.2 4918.2 5109.5 5110.2 5114.7 5118.1 4558.3 4592.9 4594.4 4601.0 4602.7 16988.2 17114.7 19086.7 20214.5 20288.9 1898.6 1958.5 2079.4 2187.8 2237.4 9439.8 9504.7 11963.3 12107.4 12708.9 1745.5 1762.0 1765.1 1785.7 1810.0 66246.0 68440.7 68642.7 69113.7 69963.7 9001.2 9057.5 9238.7 9347.3 9393.1 12172.9 12173.5 12197.8 12220.9 12283.1 6614.8 6824.4 6831.2 6886.6 7286.4 6449.3 6593.9 6643.9 6672.8 6678.1 3810.7 3815.0 4167.9 4309.5 4381.8 1729.7 1754.9 1790.9 1796.2 1807.2 812.6 815.2 842.7 845.2 894.7 16261.3 16569.6 17280.8 17333.7 17380.3 823.9 843.4 847.7 851.9 868.9 9244.6 9275.3 9685.8 9717.3 9868.8 361185.0 364334.0 364432.0 365210.0 372150.0 47895.0 49560.8 77535.2 77994.6 78102.0 806.7 851.2 851.5 852.2 853.6 15269.6 15478.4 15615.8 15616.4 16307.6 33829.0 34862.8 36092.8 38629.0 39935.8 48418.8 51783.5 52106.2 53734.0 53966.5 6634.1 6925.6 6927.5 6985.7 7213.9 8946.6 11332.7 12019.5 12290.6 12480.9 10378.8 10404.3 10422.8 10722.4 10814.9 10176.9 10386.5 10697.4 10708.1 10746.1 9982.0 10417.0 10572.4 10684.5 10870.9 7027.2 7152.8 7192.8 7258.2 7294.8 9811.8 10429.0 10496.1 10502.7 10834.5 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | [#3] mootools.html Cycles:180 Average:5196.50 Median:5205.85 stddev:2960.91 (56.9%) stddev-sans-first:2953.04 11:04:50 INFO - PROCESS | 21018 | Values: 1079.3 1092.8 1220.2 1263.3 1277.1 6551.5 7753.2 8008.0 8009.0 8010.2 8039.2 8106.9 8107.2 8109.9 8113.9 2218.5 2251.8 2252.2 2252.3 2255.2 2169.5 2208.4 2226.0 2228.7 2229.1 2186.4 2202.1 2208.4 2213.0 2228.4 2147.2 2154.4 2166.5 2168.1 2170.7 2142.2 2142.3 2143.0 2143.6 2147.8 7878.6 8011.2 8042.1 8118.2 8125.6 4708.9 4935.3 4940.0 4941.3 4947.5 2978.2 3099.0 3151.1 3155.9 3176.6 926.9 929.5 936.7 937.3 962.0 10970.3 11109.8 11111.5 11138.8 11145.8 4156.5 4205.7 4285.6 4296.8 4315.4 8698.1 8700.3 8710.2 8710.4 8711.3 4767.0 4777.1 4780.1 4785.8 4786.8 3559.3 3670.7 4158.2 4293.7 4449.1 3346.1 3350.3 3427.0 3447.7 3461.6 1048.8 1065.1 1065.2 1075.3 1075.7 697.8 819.8 827.4 830.1 838.4 5186.1 5225.6 5257.1 5310.5 5317.2 412.9 418.7 426.2 431.3 434.8 3619.3 3697.3 3776.9 3846.6 3917.6 9558.8 9835.1 9942.9 9947.3 9954.2 9863.4 9868.1 9888.2 9893.3 9896.6 6760.0 7025.1 7040.8 7209.9 7214.8 5287.4 5399.8 5408.0 5417.3 5556.8 8841.3 8902.5 9113.1 9142.7 9206.8 8893.8 8894.4 9279.1 9291.9 9306.5 6009.2 6202.3 6212.2 6962.5 7159.9 6969.4 7023.3 7291.7 7594.0 7612.4 6936.5 7149.3 7269.9 7276.1 7405.6 7063.6 7088.4 7110.2 7127.6 7217.3 6112.8 6250.8 6308.2 6415.3 6479.0 4718.3 4745.3 4785.8 4828.7 4898.3 4873.8 4942.9 4973.8 5013.5 5054.2 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | [#4] prototype.html Cycles:180 Average:4109.49 Median:4663.36 stddev:1174.12 (25.2%) stddev-sans-first:1141.98 11:04:50 INFO - PROCESS | 21018 | Values: 295.7 300.1 305.6 309.2 312.6 4578.3 4702.5 4723.7 4756.6 4775.2 4522.7 4646.3 4657.0 4666.1 4689.4 3760.5 3767.6 3769.0 3769.5 3772.1 3558.2 3749.3 3766.1 3774.7 3799.3 3479.9 3725.2 3754.2 3765.4 3776.7 3733.4 3735.6 3739.7 3765.7 3768.8 3306.9 3312.1 3314.3 3331.5 3340.2 4531.4 4560.7 4582.3 4640.0 4660.6 4221.4 4229.2 4248.7 4255.3 4267.8 4925.8 4932.5 4935.9 4942.8 4959.2 3462.8 3611.6 3630.3 3635.3 3635.9 5058.2 5065.3 5140.7 5170.3 5175.1 3653.5 3655.6 3658.7 3661.8 3663.3 3708.0 3708.8 3729.6 3764.3 3771.2 3962.9 4187.6 4189.4 4247.8 4250.4 4884.5 4897.8 4901.9 4902.8 4905.5 1180.5 1205.9 1255.6 1268.5 1276.7 834.7 868.2 871.1 876.6 882.9 4390.0 4399.7 4413.8 4416.3 4444.3 4996.9 5021.3 5046.2 5047.9 5048.7 4249.7 4393.4 4468.2 4470.8 4488.3 2668.7 2678.9 2680.7 2684.2 2693.5 4808.9 4809.9 4844.0 4848.7 4856.3 5020.5 5142.2 5157.7 5187.6 5197.8 4824.8 4827.0 4833.8 4839.8 4845.6 5041.0 5042.9 5059.4 5076.4 5080.8 4708.4 4897.5 4918.3 4941.6 4947.5 4813.0 4814.4 4815.8 4830.0 4851.5 3589.8 3613.6 3617.1 3619.8 3621.4 4822.8 5054.9 5065.4 5081.5 5091.8 4843.0 4869.8 4877.6 4882.0 4884.6 4847.6 4868.1 4878.2 4882.0 4904.1 4571.3 4588.3 4747.0 4829.3 4863.1 4775.2 4919.0 4924.3 4932.5 4934.5 4832.5 4833.4 4838.5 4858.5 4878.3 11:04:50 INFO - PROCESS | 21018 | 11:04:50 INFO - PROCESS | 21018 | [#5] yui.html Cycles:180 Average:15356.03 Median:43020.96 stddev:20716.96 (48.2%) stddev-sans-first:20745.51 11:04:50 INFO - PROCESS | 21018 | Values: 616.1 632.3 665.2 685.6 718.8 12661.2 13377.8 13387.9 13394.3 13443.9 12713.3 12734.8 12756.4 12801.9 12811.4 620.6 634.7 753.7 758.9 779.5 772.4 775.0 775.2 775.4 775.7 830.9 831.1 831.1 831.4 832.9 650.6 664.5 782.8 804.0 809.3 585.0 595.5 596.0 596.0 596.9 12174.3 12189.1 12206.9 12261.6 12297.5 12252.3 12440.3 12628.6 12737.2 12992.9 11206.5 11233.8 11479.3 11589.0 11955.9 3829.8 3831.8 3842.7 3886.4 3995.6 61278.0 61499.0 61839.7 62463.7 62496.4 9685.6 9820.9 9823.4 10012.0 10122.1 18897.1 18984.2 18985.1 19098.4 19098.5 6481.7 6511.1 6527.7 6581.7 6682.4 3527.9 3556.8 3591.5 3594.6 3689.4 2721.3 2809.9 2812.8 2817.5 2819.7 463.2 471.0 475.5 478.5 486.3 439.2 524.4 540.0 560.1 574.6 7337.7 7502.2 7650.7 7711.3 7948.8 509.9 550.4 561.3 565.3 578.0 3597.1 3639.5 3644.0 3664.7 3833.3 55104.0 80339.8 92108.5 98521.5 99406.5 45287.5 52761.5 65020.3 66982.0 82020.6 42345.8 42638.6 50340.7 65421.3 69382.7 7620.4 7893.8 8241.4 8364.5 8530.7 40126.8 41227.8 41677.2 42221.8 43403.3 34168.5 34802.0 35715.3 38591.8 38728.4 10810.8 11055.5 11067.2 11312.7 11944.7 12036.5 12044.6 12402.3 12525.7 12683.8 11063.6 11767.9 12103.1 12198.6 12351.6 11346.5 12090.5 12148.9 12185.8 12227.3 10517.7 10833.3 11182.3 11204.2 11211.4 9628.3 9727.8 9911.7 10022.8 10177.3 8508.7 9310.6 9730.7 9882.0 10046.0 11:04:50 INFO - PROCESS | 21018 | -------- Summary: end -------- 11:04:50 INFO - PROCESS | 21018 | 11:04:51 INFO - TEST-INFO | 21018: exit 0 11:04:51 INFO - TEST-OK | dromaeo_css | took 1122280ms 11:04:51 INFO - TEST-START | kraken 11:04:51 INFO - operating with platform_type : linux_ 11:04:51 INFO - Initialising browser for kraken test... 11:04:51 INFO - TEST-INFO | started process 21327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp39iSUn/profile http://localhost:35384/getInfo.html) 11:04:55 INFO - PROCESS | 21327 | __metrics Screen width/height:1600/1200 11:04:55 INFO - PROCESS | 21327 | colorDepth:24 11:04:55 INFO - PROCESS | 21327 | Browser inner width/height: 1024/697 11:04:55 INFO - PROCESS | 21327 | __metrics 11:04:56 INFO - PROCESS | 21327 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:04:56 INFO - PROCESS | 21327 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:04:56 INFO - PROCESS | 21327 | console.error: PushService: 11:04:56 INFO - PROCESS | 21327 | stateChangeProcessEnqueue: Error transitioning state 11:04:56 INFO - PROCESS | 21327 | UnknownError 11:04:57 INFO - TEST-INFO | 21327: exit 0 11:04:57 INFO - Browser initialized. 11:04:57 INFO - Running cycle 1/1 for kraken test... 11:04:57 INFO - TEST-INFO | started process 21410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp39iSUn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:09 INFO - PROCESS | 21410 | RSS: Main: 174927872 11:05:09 INFO - PROCESS | 21410 | 11:05:12 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-beat-detection) 11:05:13 INFO - PROCESS | 21410 | RSS: Main: 237600768 11:05:13 INFO - PROCESS | 21410 | 11:05:16 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-dft) 11:05:17 INFO - PROCESS | 21410 | RSS: Main: 218468352 11:05:17 INFO - PROCESS | 21410 | 11:05:20 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-fft) 11:05:20 INFO - PROCESS | 21410 | RSS: Main: 301133824 11:05:20 INFO - PROCESS | 21410 | 11:05:23 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35384/tests/kraken/driver.html?testName=audio-oscillator) 11:05:23 INFO - PROCESS | 21410 | RSS: Main: 211910656 11:05:23 INFO - PROCESS | 21410 | 11:05:26 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:05:26 INFO - PROCESS | 21410 | RSS: Main: 213860352 11:05:26 INFO - PROCESS | 21410 | 11:05:29 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35384/tests/kraken/driver.html?testName=imaging-darkroom) 11:05:30 INFO - PROCESS | 21410 | RSS: Main: 250482688 11:05:30 INFO - PROCESS | 21410 | 11:05:33 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35384/tests/kraken/driver.html?testName=imaging-desaturate) 11:05:34 INFO - PROCESS | 21410 | RSS: Main: 249446400 11:05:34 INFO - PROCESS | 21410 | 11:05:37 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35384/tests/kraken/driver.html?testName=json-parse-financial) 11:05:37 INFO - PROCESS | 21410 | RSS: Main: 249470976 11:05:37 INFO - PROCESS | 21410 | 11:05:39 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:05:40 INFO - PROCESS | 21410 | RSS: Main: 211349504 11:05:40 INFO - PROCESS | 21410 | 11:05:42 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:05:42 INFO - PROCESS | 21410 | RSS: Main: 218427392 11:05:42 INFO - PROCESS | 21410 | 11:05:45 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:05:45 INFO - PROCESS | 21410 | RSS: Main: 228089856 11:05:45 INFO - PROCESS | 21410 | 11:05:48 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:05:49 INFO - PROCESS | 21410 | RSS: Main: 236036096 11:05:49 INFO - PROCESS | 21410 | 11:05:52 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:05:52 INFO - PROCESS | 21410 | RSS: Main: 233324544 11:05:52 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | Cycle 1(1): loaded http://localhost:35384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35384/tests/kraken/driver.html?testName=ai-astar) 11:05:54 INFO - PROCESS | 21410 | RSS: Main: 283394048 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | __start_tp_report 11:05:54 INFO - PROCESS | 21410 | _x_x_mozilla_page_load 11:05:54 INFO - PROCESS | 21410 | _x_x_mozilla_page_load_details 11:05:54 INFO - PROCESS | 21410 | |i|pagename|runs| 11:05:54 INFO - PROCESS | 21410 | |0;ai-astar;113;113;114;113;114;114;114;112;115;114 11:05:54 INFO - PROCESS | 21410 | |1;audio-beat-detection;159;132;126;163;132;134;130;127;161;130 11:05:54 INFO - PROCESS | 21410 | |2;audio-dft;163;162;163;163;163;161;161;161;162;161 11:05:54 INFO - PROCESS | 21410 | |3;audio-fft;76;76;77;115;77;78;76;78;99;75 11:05:54 INFO - PROCESS | 21410 | |4;audio-oscillator;83;83;133;85;86;85;108;84;84;112 11:05:54 INFO - PROCESS | 21410 | |5;imaging-gaussian-blur;116;117;116;117;118;117;117;118;119;118 11:05:54 INFO - PROCESS | 21410 | |6;imaging-darkroom;147;146;146;146;146;146;146;145;147;146 11:05:54 INFO - PROCESS | 21410 | |7;imaging-desaturate;95;96;96;95;95;96;96;95;95;95 11:05:54 INFO - PROCESS | 21410 | |8;json-parse-financial;66;65;65;66;65;66;66;67;66;70 11:05:54 INFO - PROCESS | 21410 | |9;json-stringify-tinderbox;67;67;66;67;66;67;67;66;66;67 11:05:54 INFO - PROCESS | 21410 | |10;stanford-crypto-aes;83;85;84;82;93;87;90;84;83;92 11:05:54 INFO - PROCESS | 21410 | |11;stanford-crypto-ccm;139;138;146;140;137;137;137;138;178;144 11:05:54 INFO - PROCESS | 21410 | |12;stanford-crypto-pbkdf2;177;183;172;172;178;178;175;179;181;179 11:05:54 INFO - PROCESS | 21410 | |13;stanford-crypto-sha256-iterative;74;71;74;70;70;73;70;70;68;72 11:05:54 INFO - PROCESS | 21410 | __end_tp_report 11:05:54 INFO - PROCESS | 21410 | __start_cc_report 11:05:54 INFO - PROCESS | 21410 | _x_x_mozilla_cycle_collect,1972 11:05:54 INFO - PROCESS | 21410 | __end_cc_report 11:05:54 INFO - PROCESS | 21410 | __startTimestamp1476381954916__endTimestamp 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | ------- Summary: start ------- 11:05:54 INFO - PROCESS | 21410 | Number of tests: 14 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.84 (0.7%) stddev-sans-first:0.87 11:05:54 INFO - PROCESS | 21410 | Values: 113.0 113.0 114.0 113.0 114.0 114.0 114.0 112.0 115.0 114.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:133.00 stddev:15.12 (11.4%) stddev-sans-first:14.27 11:05:54 INFO - PROCESS | 21410 | Values: 159.0 132.0 126.0 163.0 132.0 134.0 130.0 127.0 161.0 130.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 11:05:54 INFO - PROCESS | 21410 | Values: 163.0 162.0 163.0 163.0 163.0 161.0 161.0 161.0 162.0 161.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:13.38 (17.4%) stddev-sans-first:13.97 11:05:54 INFO - PROCESS | 21410 | Values: 76.0 76.0 77.0 115.0 77.0 78.0 76.0 78.0 99.0 75.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:84.00 stddev:17.35 (20.7%) stddev-sans-first:17.91 11:05:54 INFO - PROCESS | 21410 | Values: 83.0 83.0 133.0 85.0 86.0 85.0 108.0 84.0 84.0 112.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.95 (0.8%) stddev-sans-first:0.88 11:05:54 INFO - PROCESS | 21410 | Values: 116.0 117.0 116.0 117.0 118.0 117.0 117.0 118.0 119.0 118.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 11:05:54 INFO - PROCESS | 21410 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:05:54 INFO - PROCESS | 21410 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 11:05:54 INFO - PROCESS | 21410 | Values: 66.0 65.0 65.0 66.0 65.0 66.0 66.0 67.0 66.0 70.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 11:05:54 INFO - PROCESS | 21410 | Values: 67.0 67.0 66.0 67.0 66.0 67.0 67.0 66.0 66.0 67.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:4.00 (4.7%) stddev-sans-first:4.06 11:05:54 INFO - PROCESS | 21410 | Values: 83.0 85.0 84.0 82.0 93.0 87.0 90.0 84.0 83.0 92.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:139.50 stddev:12.55 (9.0%) stddev-sans-first:13.20 11:05:54 INFO - PROCESS | 21410 | Values: 139.0 138.0 146.0 140.0 137.0 137.0 137.0 138.0 178.0 144.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:178.50 stddev:3.57 (2.0%) stddev-sans-first:3.78 11:05:54 INFO - PROCESS | 21410 | Values: 177.0 183.0 172.0 172.0 178.0 178.0 175.0 179.0 181.0 179.0 11:05:54 INFO - PROCESS | 21410 | 11:05:54 INFO - PROCESS | 21410 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:1.99 (2.8%) stddev-sans-first:1.83 11:05:54 INFO - PROCESS | 21410 | Values: 74.0 71.0 74.0 70.0 70.0 73.0 70.0 70.0 68.0 72.0 11:05:54 INFO - PROCESS | 21410 | -------- Summary: end -------- 11:05:54 INFO - PROCESS | 21410 | 11:05:56 INFO - TEST-INFO | 21410: exit 0 11:05:56 INFO - TEST-OK | kraken | took 64832ms 11:05:56 INFO - SUITE-END | took 1187s 11:05:56 INFO - Completed test suite (00:19:47) 11:05:56 INFO - javascript benchmark 11:05:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.2895953612756, 2614.4509652972874, 2648.8278261912974, 2654.442567060917, 2665.093868084852, 4595.4715207751115, 4691.812327506896, 4696.857213560999, 4792.8801779955475, 4794.161021821181, 4690.5074967128385, 4707.858764237069, 4710.882227944303, 4727.9290810637785, 4728.858134255978, 4325.956740432594, 4360.23695853226, 4373.759443230621, 4400.955990440087, 4428.889277768049, 4363.258246098171, 4391.780410979438, 4398.64810815134, 4401.185780630578, 4401.647868170555, 4382.693211475198, 4392.604665580097, 4395.1868904252815, 4420.425344705184, 4447.2439685253585, 4466.196084704752, 4487.214737420938, 4501.347304640809, 4533.5013148553635, 4552.795124219418, 4235.322348424237, 4261.616454519108, 4348.304271316574, 4391.9780401098105, 4413.44831896013, 4792.0895029944195, 4805.903881922377, 4825.20384136617, 4829.2997515360075, 4909.852704418873, 5147.819826306061, 5153.739337433027, 5165.870853228662, 5172.094883395391, 5193.506616871391, 4952.4057113146655, 4995.425526064513, 5001.249812528114, 5172.405173405069, 5190.143626301656, 4678.836240731558, 4732.787024583902, 4744.146053710365, 4762.499937506581, 4823.083614113307, 5205.323307970016, 5208.609354298443, 5214.113600687816, 5219.451957544479, 5281.102212623863, 4982.750862456863, 4991.3511243538105, 4992.051510213048, 4994.2508623706735, 5061.5950723942, 4939.086269040239, 4998.425181104147, 4999.225120106389, 5100.1074811907765, 5147.768350424165, 5121.28302037715, 5124.180131179068, 5169.9741501293, 5181.792728290826, 5183.248428977777, 5081.212412076134, 5090.363704536933, 5099.796008159632, 5101.897962040738, 5111.3355263815465, 4057.472528571267, 4093.017675757856, 4097.262492751333, 4268.765217913045, 4277.165952639268, 3675.0628589709454, 3692.9261414771554, 3694.0, 3695.8336874840697, 3748.475213470116, 4393.890152746207, 4395.956040439619, 4398.406215160912, 4413.7351758894565, 4459.264221403432, 4856.150173719585, 5037.0681423936685, 5038.84883453497, 5046.9747651261505, 5057.898842023139, 4289.528151903288, 4339.349097635317, 4433.933490997638, 4459.487158976694, 4465.553444655508, 4602.470715867651, 4606.585407313358, 4611.262198048364, 4644.256918893028, 4668.766561671903, 4894.755262236874, 4900.117978763857, 4902.730349830794, 4908.067467181224, 4965.230389289666, 4949.059678661043, 5009.599232061353, 5014.0, 5043.470435604208, 5176.0, 4820.566149046603, 4832.516748325139, 4836.322914792002, 4902.436219834622, 4916.237983112624, 5014.122528557561, 5017.64876458659, 5018.272350509229, 5018.673786203885, 5066.771995260148, 4919.1883339248625, 4988.501149884983, 5037.722925239001, 5079.263506791568, 5165.715885626327, 4934.50654934518, 4982.402111746614, 4993.0, 4995.275685025724, 5052.646314757932, 4948.826791062295, 4973.129702302155, 4979.427365852828, 4981.825636102719, 5040.924386134137, 4772.5227477252, 4920.434150072788, 4947.307376967299, 4953.281774142802, 5011.248312753116, 4906.2640603909695, 4982.053409852117, 5005.274235235943, 5014.674046187132, 5073.847784566469, 4912.38595175603, 4912.484189160086, 4925.433575138905, 4925.704457732548, 4992.101421744121], "value": 4676.472145718433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.3164139749507, 560.7420586530195, 572.4075581772865, 574.7729646789518, 579.5392662833048, 27831.44337113259, 28568.714312856864, 37933.43099853501, 39079.41380879282, 39382.60617393825, 38975.220495590074, 39271.80364098176, 39332.60667393325, 39357.212855742866, 39396.40905386421, 7521.51110177838, 7668.118166410851, 7672.386209103286, 7674.654640541189, 7678.0, 7553.924460755377, 7637.732679356223, 7638.503497272687, 7640.770776876702, 7642.808929776745, 7658.3873290136935, 7681.50070245435, 7689.961550192269, 7695.4997925134685, 7698.884516732253, 7602.42981776369, 7642.541447513167, 7647.197044310323, 7651.043619547557, 7653.15815260321, 7600.049993750781, 7658.234176582353, 7666.118396384431, 7666.9616651916385, 7668.693252269903, 36323.63676363229, 36589.634103658886, 36590.63409365899, 36709.632903671154, 36720.26559468795, 3038.4226996870525, 3146.103360542257, 3211.614606247242, 3362.1090411041096, 3362.142653623335, 27189.728102718916, 27499.587506187425, 27773.305667358276, 27895.0, 27994.0, 3435.707964822968, 3483.599386070609, 3577.159367548624, 3632.1827588792576, 3636.236390358028, 230415.0, 230587.0, 231346.0, 231898.0, 232079.0, 29953.850230748707, 49233.50766492361, 49354.75322623436, 49628.0, 49743.0, 31185.688143118732, 32817.3436531268, 33100.83449582785, 33123.171920702174, 33459.66540334614, 12739.299338536284, 12795.872041279468, 12806.103572749818, 12817.1668841525, 12835.614931552069, 9700.466474343979, 9749.31754777173, 9751.90248097524, 9762.658306959222, 9768.413895166314, 7700.807479812937, 7761.107472640606, 7811.101723301779, 7836.764897053097, 7843.72546960865, 3018.894338698135, 3083.814971101741, 3113.688631136868, 3141.89003384885, 3178.0783572764103, 838.9748307550783, 869.3610196505564, 891.5230351761776, 920.7329874336367, 971.868797712314, 27030.32424189411, 27562.5865612016, 27651.58522622162, 27695.584566231522, 28004.159875203775, 921.4701546610726, 938.5682586010512, 950.5722424908819, 954.5084281594984, 1017.0084167936351, 13995.440182392591, 14771.33528991198, 14904.925475372555, 15133.319000644777, 15185.848141518665, 357218.0, 363586.0, 364688.0, 365105.0, 365550.0, 32312.515312270334, 32606.347873042407, 32613.34773304568, 32683.673163268537, 32725.0, 1040.6825918095053, 1054.056619325699, 1091.9890801091888, 1178.8408564843808, 1193.773183095209, 25590.360240994123, 28570.857145714137, 28905.710942891143, 28956.42087158287, 29535.704642953297, 40595.0, 41063.589364105974, 41140.58859411367, 41143.17713645651, 41151.88481151861, 275257.0, 276177.0, 276345.0, 276345.0, 276513.0, 21407.46481337979, 22452.663210051534, 23520.647190291817, 24890.0, 24975.625365619893, 39400.802995984835, 39462.34535495283, 40028.799856000536, 40063.599364007154, 40472.1905561893, 34229.828850855585, 34462.310753785285, 34729.0, 35254.82372588121, 35542.64457355497, 34126.31747365089, 34528.309433811686, 34703.0, 34852.825735871156, 35190.29619407546, 34265.143371415914, 34713.0, 34819.12952176216, 34856.65143348534, 35190.29619407546, 29351.0, 31821.0, 31867.840660797476, 31950.68049319477, 31955.0, 24612.876935615208, 24840.0, 25313.49373012566, 30485.847570762893, 30834.383312334077], "value": 15734.614757903795, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.75060958548187, 368.37744212281234, 369.5491500369548, 388.1848118950203, 393.66538442324025, 15173.620659483504, 15510.379584816594, 16643.417480388172, 16811.663766724658, 16844.24200910959, 15961.521154365359, 16167.676646467064, 16311.510654680349, 16723.247453864577, 16812.747808782846, 4916.311716359713, 5192.740362981855, 5208.348956380452, 5209.322788037569, 5212.765425555859, 4959.826406075788, 5110.514501122388, 5123.641345105844, 5148.613853960949, 5175.327207463025, 5111.948880511203, 5112.0287145442435, 5128.179491281396, 5148.794048238066, 5155.200943853709, 4918.2376731606655, 5109.540141387256, 5110.156824124015, 5114.693118412907, 5118.053160165363, 4558.270676691714, 4592.931106033412, 4594.425696787902, 4601.033782905593, 4602.654800889946, 16988.150592470327, 17114.657706845792, 19086.713699294523, 20214.49463763403, 20288.898555507276, 1898.6012937283188, 1958.4907923939736, 2079.386580958606, 2187.8359123065834, 2237.3735354100877, 9439.764005899839, 9504.714858554255, 11963.342016189106, 12107.39463026854, 12708.936455317664, 1745.5461579989167, 1762.0484938133393, 1765.0821572782081, 1785.7410675451986, 1809.9547511312192, 66246.0, 68440.6577967107, 68642.65678671625, 69113.65443172753, 69963.65018174927, 9001.189892909539, 9057.456552606733, 9238.67664631748, 9347.345685801929, 9393.107654772923, 12172.878271217352, 12173.513059477522, 12197.817032744517, 12220.877791221974, 12283.140180187302, 6614.801555953329, 6824.385805277549, 6831.180258368928, 6886.586804791628, 7286.380657644159, 6449.258335291408, 6593.901091483632, 6643.86712265752, 6672.83317917056, 6678.131842860397, 3810.657040866335, 3814.961850381461, 4167.874963751093, 4309.525952145262, 4381.846635367747, 1729.714597091491, 1754.9034803085697, 1790.9462716118537, 1796.1917137288272, 1807.150639199574, 812.6099472253352, 815.2499700275761, 842.7303262955795, 845.2055068235838, 894.7002754077326, 16261.268242929096, 16569.585760355847, 17280.827191728175, 17333.7399939001, 17380.3047878086, 823.8640624296924, 843.4433274039105, 847.7160151349244, 851.9446235994765, 868.8653258744778, 9244.583993720164, 9275.304352173614, 9685.757856053515, 9717.271204659679, 9868.80262394748, 361185.0, 364334.0, 364432.0, 365210.0, 372150.0, 47895.0, 49560.75219623879, 77535.22464775393, 77994.61002695064, 78102.0, 806.733777853307, 851.1658574596929, 851.5274022917216, 852.2244757270854, 853.6329378367361, 15269.6182595436, 15478.368677325107, 15615.843841561893, 15616.375344986074, 16307.59231019234, 33829.0, 34862.82568587242, 36092.819535902156, 38629.0, 39935.80032099821, 48418.757906210245, 51783.48216517787, 52106.21840672317, 53734.0, 53966.46033539614, 6634.137562116894, 6925.6190909500465, 6927.549709268881, 6985.685644146127, 7213.855722885618, 8946.597403116744, 11332.716682083013, 12019.4591243396, 12290.569830055905, 12480.937595311965, 10378.844317335397, 10404.323718958243, 10422.843657345298, 10722.356658600509, 10814.89185108139, 10176.89823101789, 10386.532606032595, 10697.358158510515, 10708.143348531943, 10746.140308775435, 9982.0, 10417.0, 10572.36565806054, 10684.46577671129, 10870.880178365143, 7027.191872934678, 7152.785416437307, 7192.784216473514, 7258.165310989304, 7294.817629559091, 9811.754706132404, 10429.0, 10496.107830834464, 10502.68491945243, 10834.458277085956], "value": 7984.22165166878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1079.3200283821193, 1092.8360745888122, 1220.2190598017264, 1263.2799304396497, 1277.1443133100825, 6551.508636852237, 7753.185915478871, 8007.959960200191, 8009.0, 8010.198980101987, 8039.196080391958, 8106.878396824052, 8107.18928107189, 8109.891428228659, 8113.8782918256275, 2218.4786575154867, 2251.808596269319, 2252.200468833557, 2252.279270633398, 2255.221948427798, 2169.5010147665967, 2208.3595757230464, 2226.0, 2228.721409823772, 2229.1306390507634, 2186.365953873375, 2202.0641227478336, 2208.4258092895884, 2212.9557408851815, 2228.4206106412366, 2147.1840700533853, 2154.407537927075, 2166.5341951480427, 2168.056895250571, 2170.6526955687173, 2142.1752625239237, 2142.3465842917904, 2143.046344376753, 2143.6355819510723, 2147.7852214778554, 7878.566678832662, 8011.158828323, 8042.075161356402, 8118.228768267005, 8125.59372031402, 4708.882277943045, 4935.2843837643695, 4940.036692844897, 4941.332920055818, 4947.529984651488, 2978.2405486600996, 3098.9535156972665, 3151.1176870476074, 3155.9053228403186, 3176.6029246344206, 926.8748718922926, 929.4748467116058, 936.7049379445521, 937.3485427627801, 961.9855702164473, 10970.341779493256, 11109.777804443866, 11111.499982500807, 11138.832917506163, 11145.832812507737, 4156.45966024421, 4205.726627769185, 4285.5928686774705, 4296.785160741951, 4315.3742707307265, 8698.086700896441, 8700.34747393948, 8710.21608055278, 8710.390272680852, 8711.259542938795, 4766.95233047672, 4777.116233496814, 4780.115678599401, 4785.808567657255, 4786.7845946932475, 3559.341521818472, 3670.724695647837, 4158.209940111369, 4293.656507479394, 4449.065696203768, 3346.1467325832245, 3350.346682396958, 3427.0, 3447.7241820654285, 3461.584609846784, 1048.7535429174138, 1065.0787069185253, 1065.2064212161833, 1075.2849355178876, 1075.7095584192225, 697.8429853283072, 819.7581713394563, 827.4001349021911, 830.1283652165203, 838.3963546246692, 5186.118359878829, 5225.581953443715, 5257.08001099806, 5310.468953104736, 5317.175837745156, 412.93805929110874, 418.6922611880266, 426.1583372838681, 431.26469369724543, 434.83476279013775, 3619.2580520993133, 3697.2605478904325, 3776.905577360588, 3846.576876543578, 3917.6082391761165, 9558.761030974281, 9835.114839664464, 9942.850857237147, 9947.303688741864, 9954.208242516272, 9863.408195508293, 9868.111869931741, 9888.159506442033, 9893.258005649604, 9896.55465504054, 6760.019797129487, 7025.121859767529, 7040.788776336718, 7209.89185162223, 7214.819629509199, 5287.365516138088, 5399.757010934439, 5407.972960135332, 5417.268668729671, 5556.805511807067, 8841.275951189456, 8902.465852048897, 9113.088691131099, 9142.680006199751, 9206.815863682823, 8893.822123557622, 8894.42186257891, 9279.072092790937, 9291.907080929375, 9306.534673266446, 6009.188759517409, 6202.255729312511, 6212.223472065992, 6962.512624116263, 7159.928400715926, 6969.4424446045205, 7023.33278338557, 7291.708331666674, 7594.0, 7612.3910087194, 6936.514443988873, 7149.320814522612, 7269.854602908018, 7276.126864776261, 7405.62971851416, 7063.646817658993, 7088.397486213524, 7110.217876033736, 7127.607981561064, 7217.278272172741, 6112.847178820565, 6250.843728906631, 6308.211473565804, 6415.326390729093, 6479.0, 4718.292256161603, 4745.2882067690125, 4785.784639691292, 4828.686135401188, 4898.2652602109965, 4873.829415970424, 4942.925856112233, 4973.776180071833, 5013.523715247045, 5054.21659642756], "value": 4077.644728621223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.7382716296076, 300.0907251029381, 305.592034633764, 309.1883805011844, 312.6014331727049, 4578.267477203648, 4702.4827269000425, 4723.740194289313, 4756.643251756119, 4775.188218002939, 4522.670824525372, 4646.3030545418205, 4656.9534304656945, 4666.136764698533, 4689.413823272091, 3760.548734151892, 3767.585565587783, 3768.981155094221, 3769.453429252757, 3772.1135533149686, 3558.2349794794113, 3749.343864823645, 3766.0773110587943, 3774.67915227206, 3799.297130030939, 3479.9130021749406, 3725.2363265530635, 3754.2116155607355, 3765.3975363941777, 3776.716746244029, 3733.3653278942643, 3735.6451137141926, 3739.738218324718, 3765.7175711821724, 3768.8492460301554, 3306.9173270668184, 3312.138843900579, 3314.303996160809, 3331.4669652855428, 3340.1816554944194, 4531.388262584542, 4560.726356418625, 4582.33556134362, 4639.976800116012, 4660.580547750718, 4221.387898754694, 4229.238737027334, 4248.704145235702, 4255.319148936155, 4267.829286828523, 4925.827596034122, 4932.457429682732, 4935.925961110586, 4942.752862356903, 4959.156943319645, 3462.826858657057, 3611.638836116367, 3630.3102410541915, 3635.291118231946, 3635.8545658173643, 5058.2412638104215, 5065.265536497187, 5140.742962851842, 5170.302009228743, 5175.146100893348, 3653.4519822026377, 3655.634436556323, 3658.70730341572, 3661.835217415223, 3663.2673465307043, 3708.0, 3708.796016219134, 3729.589745128088, 3764.3036038333, 3771.17034252464, 3962.9009274767786, 4187.644050255702, 4189.371594260885, 4247.8088486018205, 4250.362445633118, 4884.4871288514905, 4897.804087836518, 4901.852944411602, 4902.754862256944, 4905.509449055137, 1180.5100883133575, 1205.8604618635306, 1255.5919326219016, 1268.536984000833, 1276.6999755057554, 834.7203686765001, 868.2316150206985, 871.1288711288711, 876.6186708781573, 882.9360620452339, 4390.0, 4399.670024748157, 4413.801378937956, 4416.337549367557, 4444.31113177458, 4996.875078123004, 5021.347224860745, 5046.1926091825135, 5047.899042019139, 5048.671836330626, 4249.723767955073, 4393.384926110347, 4468.240399132155, 4470.754108524063, 4488.304312831517, 2668.7331266873157, 2678.8882613715477, 2680.7051224365305, 2684.1813246959864, 2693.5286324893063, 4808.8797780055775, 4809.855704328876, 4844.0, 4848.684835485753, 4856.344393506902, 5020.47285035066, 5142.177251639794, 5157.742112894341, 5187.610929180251, 5197.818076367309, 4824.831130910471, 4826.95173048272, 4833.782479788348, 4839.765859705823, 4845.63657725665, 5040.974795126148, 5042.949570504248, 5059.443461219189, 5076.36545431821, 5080.847574572768, 4708.387909571734, 4897.4857639947295, 4918.311436398979, 4941.555260026615, 4947.505249475023, 4812.951870481251, 4814.350062741625, 4815.807367705253, 4829.991107380935, 4851.51484851512, 3589.820508974593, 3613.620569840234, 3617.0957260684827, 3619.8190090495896, 3621.4386770050683, 4822.831200907952, 5054.924176137434, 5065.39215294167, 5081.5426611605135, 5091.770870310771, 4843.007183527439, 4869.829555965524, 4877.6341774367775, 4882.0, 4884.5603895649565, 4847.61219102478, 4868.101440438303, 4878.219484882402, 4882.048000639983, 4904.062895156465, 4571.26859702446, 4588.26587745959, 4747.0, 4829.299751536078, 4863.148948933993, 4775.21209000525, 4919.0, 4924.325729251928, 4932.506749325039, 4934.457209706858, 4832.477769502595, 4833.371661683958, 4838.467768545527, 4858.46556878736, 4878.268259761065], "value": 3739.158223451307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.063583353303, 632.3234139470762, 665.1552528289071, 685.5920727167335, 718.7699936020475, 12661.177023493467, 13377.799333010013, 13387.93306033471, 13394.263315517643, 13443.932780336097, 12713.300768457731, 12734.808977865316, 12756.362181890914, 12801.935990320058, 12811.359432028408, 620.5873094392224, 634.6604566556892, 753.6683859101992, 758.859610971972, 779.5478622399023, 772.4168252969029, 774.9728759493419, 775.151209425678, 775.3796962430062, 775.7246177606953, 830.8961379827522, 831.1107115386538, 831.1397703377006, 831.4346244553701, 832.8875601793771, 650.5901282192212, 664.4651055899999, 782.8434313137395, 804.0271271761176, 809.3080416244144, 585.0405335250193, 595.4849055566947, 595.9851003724898, 596.0493013643276, 596.8507873031742, 12174.330411827346, 12189.085818563555, 12206.938965305117, 12261.632151035394, 12297.508099676003, 12252.264864108181, 12440.253584784941, 12628.558000469939, 12737.172083814523, 12992.935035324763, 11206.495707693091, 11233.775324493547, 11479.311241325464, 11589.0, 11955.880441195564, 3829.751066180689, 3831.7892515911612, 3842.6733727633186, 3886.417037444378, 3995.60043995601, 61278.0, 61499.0, 61839.6908015457, 62463.68768156176, 62496.37503624951, 9685.612575497042, 9820.857325655865, 9823.410595364301, 10012.04885535873, 10122.089011988955, 18897.055147242583, 18984.240630374905, 18985.145668444955, 19098.427047188605, 19098.52253693641, 6481.740730370732, 6511.120998665119, 6527.706253218616, 6581.736730530725, 6682.431993280528, 3527.876524321636, 3556.8043757593064, 3591.51514545533, 3594.5866225383893, 3689.4465830125696, 2721.265258380266, 2809.9157025289273, 2812.7890408219055, 2817.4505971335802, 2819.746222839954, 463.16167736396557, 470.9646776491708, 475.51972507766715, 478.4880178209352, 486.3215813939605, 439.19188692804755, 524.3969435149609, 540.0198639469351, 560.1206106412893, 574.5575906551932, 7337.706491740378, 7502.17476077631, 7650.693972241048, 7711.344535714415, 7948.761537153895, 509.9184130539096, 550.4193076304538, 561.3348182403864, 565.3216140631259, 577.9855503612443, 3597.0647631615966, 3639.454081887738, 3643.9635603644156, 3664.72514561409, 3833.3483307837732, 55104.0, 80339.7949030765, 92108.53945730228, 98521.50739246258, 99406.5029674847, 45287.54712452833, 52761.47238527566, 65020.34979650238, 66982.0, 82020.58989705013, 42345.788271058445, 42638.57361426346, 50340.748296259015, 65421.34578654248, 69382.65308673424, 7620.399716059689, 7893.802654933443, 8241.423100382915, 8364.456310339809, 8530.658773648984, 40126.79936600298, 41227.7938610317, 41677.16645667009, 42221.788891055345, 43403.34894976641, 34168.48747268843, 34802.0, 35715.28569428545, 38591.80704096462, 38728.419073713354, 10810.783784324427, 11055.502502387573, 11067.169962253025, 11312.717182070513, 11944.70138246516, 12036.518539258332, 12044.603719642093, 12402.25586464815, 12525.74948501043, 12683.80974285405, 11063.626549121595, 11767.882321177021, 12103.092268080105, 12198.57304994321, 12351.567695130627, 11346.546138154381, 12090.516379344728, 12148.939255303667, 12185.756284874076, 12227.327496987395, 10517.73705657334, 10833.349999000086, 11182.273152245078, 11204.159688023268, 11211.439428028403, 9628.277879158952, 9727.756806079904, 9911.65309214174, 10022.799544008933, 10177.338472999232, 8508.712153242483, 9310.627574897198, 9730.708078757649, 9881.950590247003, 10046.0], "value": 6201.731238444327, "unit": "score"}], "name": "dromaeo_css", "value": 6177.197481628718, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 112.0, 115.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 126.0, 163.0, 132.0, 134.0, 130.0, 127.0, 161.0, 130.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 115.0, 77.0, 78.0, 76.0, 78.0, 99.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 133.0, 85.0, 86.0, 85.0, 108.0, 84.0, 84.0, 112.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 70.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 82.0, 93.0, 87.0, 90.0, 84.0, 83.0, 92.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 146.0, 140.0, 137.0, 137.0, 137.0, 138.0, 178.0, 144.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 183.0, 172.0, 172.0, 178.0, 178.0, 175.0, 179.0, 181.0, 179.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 74.0, 70.0, 70.0, 73.0, 70.0, 70.0, 68.0, 72.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1561.9, "alertThreshold": 2.0}]} 11:05:56 INFO - Return code: 0 11:05:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:05:56 INFO - # TBPL SUCCESS # 11:05:56 INFO - Running post-action listener: _resource_record_post_action 11:05:56 INFO - [mozharness: 2016-10-13 18:05:56.700600Z] Finished run-tests step (success) 11:05:56 INFO - Running post-run listener: _resource_record_post_run 11:05:56 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409477120; Read time: 8; Write time: 297932 11:05:56 INFO - TinderboxPrint: CPU usage
13.0% 11:05:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:05:56 INFO - TinderboxPrint: I/O write bytes / time
409,477,120 / 297,932 11:05:56 INFO - TinderboxPrint: CPU idle
8,353.1 (86.9%) 11:05:56 INFO - TinderboxPrint: CPU user
1,205.2 (12.5%) 11:05:56 INFO - TinderboxPrint: Swap in / out
0 / 0 11:05:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115539968; Read time: 0; Write time: 68480 11:05:56 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 293937152; Read time: 0; Write time: 229452 11:05:57 INFO - Running post-run listener: _upload_blobber_files 11:05:57 INFO - Blob upload gear active. 11:05:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:05:57 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 11:05:57 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:05:57 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:05:57 INFO - (blobuploader) - INFO - Open directory for files ... 11:05:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:05:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:01 INFO - (blobuploader) - INFO - Done attempting. 11:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:06:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:01 INFO - (blobuploader) - INFO - Done attempting. 11:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:06:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:06:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:06:02 INFO - (blobuploader) - INFO - Done attempting. 11:06:02 INFO - (blobuploader) - INFO - Iteration through files over. 11:06:02 INFO - Return code: 0 11:06:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:06:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:06:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c862aadcf7215345b3f476318c192e75808c2b28a5005a984a259a608d62f37222b1f23942af4bd2f65089497d700c1ab20ba1b92efd2e652a57a51fe2031324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c19e377202aa48a5adeb21dc3fd49ade9a4e07255c8f87f60fa0689634dc79a4cbb73c1d25a7e2cd0062d08aec93f9f3dd63e6a087a720c7216aaff437723c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f45dd639a553c1a18b641980d03647cd6ab8f495f19569aabcbd24a803ceb4ab2e5decc501af4cd37c4a775986dc8ce30b226112f662054b7155fe8ada9189f0"} 11:06:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:06:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:06:02 INFO - Contents: 11:06:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c862aadcf7215345b3f476318c192e75808c2b28a5005a984a259a608d62f37222b1f23942af4bd2f65089497d700c1ab20ba1b92efd2e652a57a51fe2031324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c19e377202aa48a5adeb21dc3fd49ade9a4e07255c8f87f60fa0689634dc79a4cbb73c1d25a7e2cd0062d08aec93f9f3dd63e6a087a720c7216aaff437723c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f45dd639a553c1a18b641980d03647cd6ab8f495f19569aabcbd24a803ceb4ab2e5decc501af4cd37c4a775986dc8ce30b226112f662054b7155fe8ada9189f0"} 11:06:02 INFO - Running post-run listener: copy_logs_to_upload_dir 11:06:02 INFO - Copying logs to upload dir... 11:06:02 INFO - mkdir: /builds/slave/test/build/upload/logs 11:06:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.196103 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-13 11:06:02.483844) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 11:06:02.487764) ========= 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=523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c862aadcf7215345b3f476318c192e75808c2b28a5005a984a259a608d62f37222b1f23942af4bd2f65089497d700c1ab20ba1b92efd2e652a57a51fe2031324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c19e377202aa48a5adeb21dc3fd49ade9a4e07255c8f87f60fa0689634dc79a4cbb73c1d25a7e2cd0062d08aec93f9f3dd63e6a087a720c7216aaff437723c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f45dd639a553c1a18b641980d03647cd6ab8f495f19569aabcbd24a803ceb4ab2e5decc501af4cd37c4a775986dc8ce30b226112f662054b7155fe8ada9189f0"} build_url:https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/Jsvf_AJeSq2E1bAStk-u2A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c862aadcf7215345b3f476318c192e75808c2b28a5005a984a259a608d62f37222b1f23942af4bd2f65089497d700c1ab20ba1b92efd2e652a57a51fe2031324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c19e377202aa48a5adeb21dc3fd49ade9a4e07255c8f87f60fa0689634dc79a4cbb73c1d25a7e2cd0062d08aec93f9f3dd63e6a087a720c7216aaff437723c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f45dd639a553c1a18b641980d03647cd6ab8f495f19569aabcbd24a803ceb4ab2e5decc501af4cd37c4a775986dc8ce30b226112f662054b7155fe8ada9189f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 11:06:02.513083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 11:06:02.513476) ========= 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=523ca41ca1e0623de333ad52000001bf-1476380713.122865-1785224240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 11:06:02.599529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 11:06:02.599888) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 11:06:02.600219) ========= ========= Total master_lag: 0.15 =========